builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0013 starttime: 1493810059.44 results: success (0) buildid: 20170503031721 builduid: 4474aa6419694b68b9530c19135fac6f revision: bd2ab9d0d30dad50f82b530cdd6194ed07110ee0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:19.437190) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:19.437623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:19.437906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:19.464879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:19.465273) ========= 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.8GVdzmHmtq/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.E606IiTPXU/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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-05-03 04:14:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 194M=0s 2017-05-03 04:14:19 (194 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.172768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:19.663033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:19.663343) ========= 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.8GVdzmHmtq/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.E606IiTPXU/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.027685 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:19.713703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 04:14:19.714067) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bd2ab9d0d30dad50f82b530cdd6194ed07110ee0 --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-beta --rev bd2ab9d0d30dad50f82b530cdd6194ed07110ee0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8GVdzmHmtq/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.E606IiTPXU/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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-05-03 04:14:19,813 truncating revision to first 12 chars 2017-05-03 04:14:19,813 Setting DEBUG logging. 2017-05-03 04:14:19,813 attempt 1/10 2017-05-03 04:14:19,813 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bd2ab9d0d30d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 04:14:20,761 unpacking tar archive at: mozilla-beta-bd2ab9d0d30d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.220216 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 04:14:20.958270) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:20.958675) ========= script_repo_revision: bd2ab9d0d30dad50f82b530cdd6194ed07110ee0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:20.959081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:20.959341) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 04:14:20.979923) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-05-03 04:14:20.980330) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8GVdzmHmtq/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.E606IiTPXU/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:14:21 INFO - MultiFileLogger online at 20170503 04:14:21 in /builds/slave/test 04:14:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:14:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:14:21 INFO - {'append_to_log': False, 04:14:21 INFO - 'base_work_dir': '/builds/slave/test', 04:14:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:14:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:14:21 INFO - 'branch': 'Mozilla-Beta', 04:14:21 INFO - 'buildbot_json_path': 'buildprops.json', 04:14:21 INFO - 'config_files': ('talos/mac_config.py',), 04:14:21 INFO - 'default_actions': ('clobber', 04:14:21 INFO - 'read-buildbot-config', 04:14:21 INFO - 'download-and-extract', 04:14:21 INFO - 'populate-webroot', 04:14:21 INFO - 'create-virtualenv', 04:14:21 INFO - 'install', 04:14:21 INFO - 'run-tests'), 04:14:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:14:21 INFO - 'download_minidump_stackwalk': True, 04:14:21 INFO - 'download_symbols': 'ondemand', 04:14:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:14:21 INFO - 'tooltool.py': '/tools/tooltool.py', 04:14:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:14:21 INFO - '/tools/misc-python/virtualenv.py')}, 04:14:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:14:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:14:21 INFO - 'gecko_profile': False, 04:14:21 INFO - 'gecko_profile_interval': 0, 04:14:21 INFO - 'installer_path': 'installer.exe', 04:14:21 INFO - 'log_level': 'info', 04:14:21 INFO - 'log_name': 'talos', 04:14:21 INFO - 'log_to_console': True, 04:14:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:14:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:14:21 INFO - 'opt_config_files': (), 04:14:21 INFO - 'pip_index': False, 04:14:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:14:21 INFO - 'cmd': ('bash', 04:14:21 INFO - '-c', 04:14:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:14:21 INFO - 'enabled': True, 04:14:21 INFO - 'halt_on_failure': False, 04:14:21 INFO - 'name': 'check_screen_resolution'},), 04:14:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:14:21 INFO - 'cmd': ('bash', 04:14:21 INFO - '-c', 04:14:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:14:21 INFO - 'enabled': True, 04:14:21 INFO - 'halt_on_failure': False, 04:14:21 INFO - 'name': 'check_screen_resolution'},), 04:14:21 INFO - 'run_cmd_checks_enabled': True, 04:14:21 INFO - 'suite': 'dromaeojs', 04:14:21 INFO - 'system_bits': '32', 04:14:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:14:21 INFO - 'title': 't-yosemite-r7-0013', 04:14:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:14:21 INFO - 'use_talos_json': True, 04:14:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:14:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:14:21 INFO - 'work_dir': 'build'} 04:14:21 INFO - [mozharness: 2017-05-03 11:14:21.194030Z] Running clobber step. 04:14:21 INFO - Running pre-action listener: _resource_record_pre_action 04:14:21 INFO - Running main action method: clobber 04:14:21 INFO - rmtree: /builds/slave/test/build 04:14:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:14:23 INFO - Running post-action listener: _resource_record_post_action 04:14:23 INFO - [mozharness: 2017-05-03 11:14:23.689341Z] Finished clobber step (success) 04:14:23 INFO - [mozharness: 2017-05-03 11:14:23.689496Z] Running read-buildbot-config step. 04:14:23 INFO - Running pre-action listener: _resource_record_pre_action 04:14:23 INFO - Running main action method: read_buildbot_config 04:14:23 INFO - Using buildbot properties: 04:14:23 INFO - { 04:14:23 INFO - "project": "", 04:14:23 INFO - "product": "firefox", 04:14:23 INFO - "script_repo_revision": "production", 04:14:23 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:14:23 INFO - "repository": "", 04:14:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:14:23 INFO - "buildid": "20170503031721", 04:14:23 INFO - "pgo_build": "False", 04:14:23 INFO - "basedir": "/builds/slave/test", 04:14:23 INFO - "buildnumber": 5, 04:14:23 INFO - "slavename": "t-yosemite-r7-0013", 04:14:23 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:14:23 INFO - "platform": "yosemite_r7", 04:14:23 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:14:23 INFO - "branch": "mozilla-beta", 04:14:23 INFO - "repo_path": "releases/mozilla-beta", 04:14:23 INFO - "revision": "bd2ab9d0d30dad50f82b530cdd6194ed07110ee0", 04:14:23 INFO - "stage_platform": "macosx64", 04:14:23 INFO - "builduid": "4474aa6419694b68b9530c19135fac6f", 04:14:23 INFO - "slavebuilddir": "test" 04:14:23 INFO - } 04:14:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 04:14:23 INFO - Running post-action listener: _resource_record_post_action 04:14:23 INFO - [mozharness: 2017-05-03 11:14:23.693037Z] Finished read-buildbot-config step (success) 04:14:23 INFO - [mozharness: 2017-05-03 11:14:23.693173Z] Running download-and-extract step. 04:14:23 INFO - Running pre-action listener: _resource_record_pre_action 04:14:23 INFO - Running main action method: download_and_extract 04:14:23 INFO - mkdir: /builds/slave/test/build/tests 04:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:23 INFO - trying https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 04:14:23 INFO - Downloading https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 04:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 04:14:25 INFO - Downloaded 1287 bytes. 04:14:25 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 04:14:25 INFO - Using the following test package requirements: 04:14:25 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:14:25 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 04:14:25 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 04:14:25 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:14:25 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 04:14:25 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:14:25 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 04:14:25 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:14:25 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:14:25 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 04:14:25 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 04:14:25 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:14:25 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 04:14:25 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:14:25 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 04:14:25 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:14:25 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 04:14:25 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:14:25 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 04:14:25 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 04:14:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 04:14:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 04:14:25 INFO - Fetch https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 04:14:26 INFO - Expected file size: 51223625 04:14:26 INFO - Obtained file size: 51223625 04:14:42 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:14:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 04:14:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 04:14:42 INFO - Fetch https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 04:14:44 INFO - Expected file size: 51223625 04:14:44 INFO - Obtained file size: 51223625 04:14:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 04:14:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 04:14:59 INFO - Fetch https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 04:15:00 INFO - Expected file size: 14404449 04:15:00 INFO - Obtained file size: 14404449 04:15:00 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:15:00 INFO - trying https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 04:15:00 INFO - Downloading https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 04:15:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 04:15:02 INFO - Downloaded 59543141 bytes. 04:15:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 04:15:02 INFO - mkdir: /builds/slave/test/properties 04:15:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:15:02 INFO - Writing to file /builds/slave/test/properties/build_url 04:15:02 INFO - Contents: 04:15:02 INFO - build_url:https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 04:15:03 INFO - Running post-action listener: _resource_record_post_action 04:15:03 INFO - Running post-action listener: set_extra_try_arguments 04:15:03 INFO - [mozharness: 2017-05-03 11:15:03.005297Z] Finished download-and-extract step (success) 04:15:03 INFO - [mozharness: 2017-05-03 11:15:03.005412Z] Running populate-webroot step. 04:15:03 INFO - Running pre-action listener: _resource_record_pre_action 04:15:03 INFO - Running main action method: populate_webroot 04:15:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:15:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:15:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:15:03 INFO - '--tppagecycles', 04:15:03 INFO - '7'], 04:15:03 INFO - 'tests': ['tsvgm']}}, 04:15:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:15:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:15:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:15:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:15:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:15:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:15:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:15:03 INFO - 'talos_options': ['--disable-e10s'], 04:15:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:15:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:15:03 INFO - 'talos_options': ['--disable-e10s'], 04:15:03 INFO - 'tests': ['damp', 'tps']}, 04:15:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:15:03 INFO - 'tests': ['damp', 'tps']}, 04:15:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:15:03 INFO - 'tests': ['dromaeo_dom']}, 04:15:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:15:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:15:03 INFO - 'tests': ['basic_compositor_video']}, 04:15:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:15:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:15:03 INFO - 'tests': ['a11yr', 04:15:03 INFO - 'ts_paint', 04:15:03 INFO - 'tpaint', 04:15:03 INFO - 'sessionrestore', 04:15:03 INFO - 'sessionrestore_no_auto_restore', 04:15:03 INFO - 'tabpaint']}, 04:15:03 INFO - 'other-e10s': {'tests': ['a11yr', 04:15:03 INFO - 'ts_paint', 04:15:03 INFO - 'tpaint', 04:15:03 INFO - 'sessionrestore', 04:15:03 INFO - 'sessionrestore_no_auto_restore', 04:15:03 INFO - 'tabpaint']}, 04:15:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:15:03 INFO - 'ts_paint', 04:15:03 INFO - 'tpaint', 04:15:03 INFO - 'sessionrestore', 04:15:03 INFO - 'sessionrestore_no_auto_restore', 04:15:03 INFO - 'tabpaint']}, 04:15:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:15:03 INFO - 'ts_paint', 04:15:03 INFO - 'tpaint', 04:15:03 INFO - 'sessionrestore', 04:15:03 INFO - 'sessionrestore_no_auto_restore', 04:15:03 INFO - 'tabpaint']}, 04:15:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:15:03 INFO - 'tests': ['a11yr', 04:15:03 INFO - 'ts_paint', 04:15:03 INFO - 'tpaint', 04:15:03 INFO - 'sessionrestore', 04:15:03 INFO - 'sessionrestore_no_auto_restore', 04:15:03 INFO - 'tabpaint']}, 04:15:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:15:03 INFO - 'tests': ['a11yr', 04:15:03 INFO - 'ts_paint', 04:15:03 INFO - 'tpaint', 04:15:03 INFO - 'sessionrestore', 04:15:03 INFO - 'sessionrestore_no_auto_restore', 04:15:03 INFO - 'tabpaint']}, 04:15:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:15:03 INFO - 'tests': ['tsvgx', 04:15:03 INFO - 'tsvgr_opacity', 04:15:03 INFO - 'tart', 04:15:03 INFO - 'tscrollx', 04:15:03 INFO - 'cart', 04:15:03 INFO - 'tsvg_static']}, 04:15:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:15:03 INFO - 'tsvgr_opacity', 04:15:03 INFO - 'tart', 04:15:03 INFO - 'tscrollx', 04:15:03 INFO - 'cart', 04:15:03 INFO - 'tsvg_static']}, 04:15:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:15:03 INFO - 'talos_options': ['--disable-e10s'], 04:15:03 INFO - 'tests': ['tp5o']}, 04:15:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:15:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:15:03 INFO - 'talos_options': ['--disable-e10s', 04:15:03 INFO - '--xperf_path', 04:15:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:03 INFO - 'tests': ['tp5n']}, 04:15:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:15:03 INFO - 'talos_options': ['--xperf_path', 04:15:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:03 INFO - 'tests': ['tp5n']}}, 04:15:03 INFO - 'talos.zip': {'path': '', 04:15:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:15:03 INFO - Running post-action listener: _resource_record_post_action 04:15:03 INFO - [mozharness: 2017-05-03 11:15:03.023910Z] Finished populate-webroot step (success) 04:15:03 INFO - [mozharness: 2017-05-03 11:15:03.024042Z] Running create-virtualenv step. 04:15:03 INFO - Running pre-action listener: _resource_record_pre_action 04:15:03 INFO - Running main action method: create_virtualenv 04:15:03 INFO - Creating virtualenv /builds/slave/test/build/venv 04:15:03 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:15:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:15:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:15:03 INFO - Using real prefix '/tools/python27' 04:15:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:15:03 INFO - Installing distribute.............................................................................................................................................................................................done. 04:15:06 INFO - Installing pip.................done. 04:15:06 INFO - Return code: 0 04:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:15:07 INFO - Reading from file tmpfile_stdout 04:15:07 INFO - Output received: 04:15:07 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:15:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:15:07 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:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:07 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:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:07 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 0x103c4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7b14b82d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a28d30>, '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 0x10394fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a1dbe8>, '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.8GVdzmHmtq/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.E606IiTPXU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:15:07 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:15:07 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:15:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GVdzmHmtq/Render', 04:15:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:07 INFO - 'HOME': '/Users/cltbld', 04:15:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:07 INFO - 'LOGNAME': 'cltbld', 04:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:07 INFO - 'MOZ_NO_REMOTE': '1', 04:15:07 INFO - 'NO_EM_RESTART': '1', 04:15:07 INFO - 'PAGER': '/bin/cat', 04:15:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:07 INFO - 'PWD': '/builds/slave/test', 04:15:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:07 INFO - 'SHELL': '/bin/bash', 04:15:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E606IiTPXU/Listeners', 04:15:07 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 04:15:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:07 INFO - 'USER': 'cltbld', 04:15:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:07 INFO - 'XPC_FLAGS': '0x0', 04:15:07 INFO - 'XPC_SERVICE_NAME': '0', 04:15:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:07 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:15:07 INFO - Cleaning up... 04:15:07 INFO - Return code: 0 04:15:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:15:07 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:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:07 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:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:07 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 0x103c4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7b14b82d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a28d30>, '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 0x10394fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a1dbe8>, '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.8GVdzmHmtq/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.E606IiTPXU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:15:07 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:15:07 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:15:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GVdzmHmtq/Render', 04:15:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:07 INFO - 'HOME': '/Users/cltbld', 04:15:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:07 INFO - 'LOGNAME': 'cltbld', 04:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:07 INFO - 'MOZ_NO_REMOTE': '1', 04:15:07 INFO - 'NO_EM_RESTART': '1', 04:15:07 INFO - 'PAGER': '/bin/cat', 04:15:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:07 INFO - 'PWD': '/builds/slave/test', 04:15:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:07 INFO - 'SHELL': '/bin/bash', 04:15:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E606IiTPXU/Listeners', 04:15:07 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 04:15:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:07 INFO - 'USER': 'cltbld', 04:15:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:07 INFO - 'XPC_FLAGS': '0x0', 04:15:07 INFO - 'XPC_SERVICE_NAME': '0', 04:15:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:07 INFO - Downloading/unpacking psutil>=3.1.1 04:15:07 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:15:07 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:15:07 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:15:07 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:15:07 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:15:07 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:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:15:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:09 INFO - Installing collected packages: psutil 04:15:09 INFO - Running setup.py install for psutil 04:15:09 INFO - building 'psutil._psutil_osx' extension 04:15:09 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:15:10 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:15:10 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:15:10 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:15:10 INFO - building 'psutil._psutil_posix' extension 04:15:10 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:15:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:15:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:15:10 INFO - ^ 04:15:10 INFO - 1 warning generated. 04:15:10 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:15:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:10 INFO - Successfully installed psutil 04:15:10 INFO - Cleaning up... 04:15:11 INFO - Return code: 0 04:15:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103c4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7b14b82d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a28d30>, '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 0x10394fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a1dbe8>, '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.8GVdzmHmtq/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.E606IiTPXU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:15:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:15:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GVdzmHmtq/Render', 04:15:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:11 INFO - 'HOME': '/Users/cltbld', 04:15:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:11 INFO - 'LOGNAME': 'cltbld', 04:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:11 INFO - 'MOZ_NO_REMOTE': '1', 04:15:11 INFO - 'NO_EM_RESTART': '1', 04:15:11 INFO - 'PAGER': '/bin/cat', 04:15:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:11 INFO - 'PWD': '/builds/slave/test', 04:15:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:11 INFO - 'SHELL': '/bin/bash', 04:15:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E606IiTPXU/Listeners', 04:15:11 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 04:15:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:11 INFO - 'USER': 'cltbld', 04:15:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:11 INFO - 'XPC_FLAGS': '0x0', 04:15:11 INFO - 'XPC_SERVICE_NAME': '0', 04:15:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:15:11 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:15:11 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:15:11 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:15:11 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:15:11 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:15:11 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:15:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:15:12 INFO - Installing collected packages: mozsystemmonitor 04:15:12 INFO - Running setup.py install for mozsystemmonitor 04:15:12 INFO - Successfully installed mozsystemmonitor 04:15:12 INFO - Cleaning up... 04:15:12 INFO - Return code: 0 04:15:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:13 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:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:13 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 0x103c4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7b14b82d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a28d30>, '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 0x10394fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a1dbe8>, '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.8GVdzmHmtq/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.E606IiTPXU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:15:13 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:15:13 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:15:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GVdzmHmtq/Render', 04:15:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:13 INFO - 'HOME': '/Users/cltbld', 04:15:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:13 INFO - 'LOGNAME': 'cltbld', 04:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:13 INFO - 'MOZ_NO_REMOTE': '1', 04:15:13 INFO - 'NO_EM_RESTART': '1', 04:15:13 INFO - 'PAGER': '/bin/cat', 04:15:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:13 INFO - 'PWD': '/builds/slave/test', 04:15:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:13 INFO - 'SHELL': '/bin/bash', 04:15:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E606IiTPXU/Listeners', 04:15:13 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 04:15:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:13 INFO - 'USER': 'cltbld', 04:15:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:13 INFO - 'XPC_FLAGS': '0x0', 04:15:13 INFO - 'XPC_SERVICE_NAME': '0', 04:15:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:13 INFO - Downloading/unpacking jsonschema==2.5.1 04:15:13 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:15:13 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:15:13 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:15:13 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:15:13 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:15:13 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:15:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:15:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:15:15 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:15:15 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:15:15 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:15:15 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:15:15 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:15:15 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:15:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:15:15 INFO - warning: no files found matching '*.txt' 04:15:15 INFO - no previously-included directories found matching 'build' 04:15:15 INFO - no previously-included directories found matching 'dist' 04:15:15 INFO - no previously-included directories found matching '.git*' 04:15:15 INFO - Installing collected packages: jsonschema, functools32 04:15:16 INFO - Running setup.py install for functools32 04:15:16 INFO - warning: no files found matching '*.txt' 04:15:16 INFO - no previously-included directories found matching 'build' 04:15:16 INFO - no previously-included directories found matching 'dist' 04:15:16 INFO - no previously-included directories found matching '.git*' 04:15:16 INFO - Successfully installed jsonschema functools32 04:15:16 INFO - Cleaning up... 04:15:16 INFO - Return code: 0 04:15:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:15:16 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:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:16 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:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:16 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 0x103c4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7b14b82d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a28d30>, '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 0x10394fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a1dbe8>, '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.8GVdzmHmtq/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.E606IiTPXU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:15:16 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:15:16 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:15:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GVdzmHmtq/Render', 04:15:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:16 INFO - 'HOME': '/Users/cltbld', 04:15:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:16 INFO - 'LOGNAME': 'cltbld', 04:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:16 INFO - 'MOZ_NO_REMOTE': '1', 04:15:16 INFO - 'NO_EM_RESTART': '1', 04:15:16 INFO - 'PAGER': '/bin/cat', 04:15:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:16 INFO - 'PWD': '/builds/slave/test', 04:15:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:16 INFO - 'SHELL': '/bin/bash', 04:15:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E606IiTPXU/Listeners', 04:15:16 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 04:15:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:16 INFO - 'USER': 'cltbld', 04:15:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:16 INFO - 'XPC_FLAGS': '0x0', 04:15:16 INFO - 'XPC_SERVICE_NAME': '0', 04:15:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:15:16 INFO - Cleaning up... 04:15:16 INFO - Return code: 0 04:15:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:15:16 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:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:16 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:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:16 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 0x103c4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7b14b82d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a28d30>, '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 0x10394fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a1dbe8>, '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.8GVdzmHmtq/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.E606IiTPXU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:15:16 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:15:16 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:15:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GVdzmHmtq/Render', 04:15:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:16 INFO - 'HOME': '/Users/cltbld', 04:15:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:16 INFO - 'LOGNAME': 'cltbld', 04:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:16 INFO - 'MOZ_NO_REMOTE': '1', 04:15:16 INFO - 'NO_EM_RESTART': '1', 04:15:16 INFO - 'PAGER': '/bin/cat', 04:15:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:16 INFO - 'PWD': '/builds/slave/test', 04:15:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:16 INFO - 'SHELL': '/bin/bash', 04:15:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E606IiTPXU/Listeners', 04:15:16 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 04:15:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:16 INFO - 'USER': 'cltbld', 04:15:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:16 INFO - 'XPC_FLAGS': '0x0', 04:15:16 INFO - 'XPC_SERVICE_NAME': '0', 04:15:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:16 INFO - Downloading/unpacking blobuploader==1.2.4 04:15:16 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:15:16 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:15:16 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:15:16 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:15:16 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:15:16 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:15:18 INFO - Downloading blobuploader-1.2.4.tar.gz 04:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:15:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:15:18 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:15:18 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:15:18 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:15:18 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:15:18 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:15:18 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:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:15:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:15:18 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:15:18 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:15:18 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:15:18 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:15:18 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:15:18 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:15:18 INFO - Downloading docopt-0.6.1.tar.gz 04:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:15:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:15:19 INFO - Running setup.py install for blobuploader 04:15:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:15:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:15:19 INFO - Running setup.py install for requests 04:15:19 INFO - Running setup.py install for docopt 04:15:19 INFO - Successfully installed blobuploader requests docopt 04:15:19 INFO - Cleaning up... 04:15:19 INFO - Return code: 0 04:15:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:19 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:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:19 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:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:19 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 0x103c4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7b14b82d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a28d30>, '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 0x10394fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a1dbe8>, '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.8GVdzmHmtq/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.E606IiTPXU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:15:19 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:15:19 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:15:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GVdzmHmtq/Render', 04:15:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:19 INFO - 'HOME': '/Users/cltbld', 04:15:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:19 INFO - 'LOGNAME': 'cltbld', 04:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:19 INFO - 'MOZ_NO_REMOTE': '1', 04:15:19 INFO - 'NO_EM_RESTART': '1', 04:15:19 INFO - 'PAGER': '/bin/cat', 04:15:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:19 INFO - 'PWD': '/builds/slave/test', 04:15:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:19 INFO - 'SHELL': '/bin/bash', 04:15:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E606IiTPXU/Listeners', 04:15:19 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 04:15:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:19 INFO - 'USER': 'cltbld', 04:15:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:19 INFO - 'XPC_FLAGS': '0x0', 04:15:19 INFO - 'XPC_SERVICE_NAME': '0', 04:15:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:15:20 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-hAILBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:15:20 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-h77OSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:15:20 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-VVD_Gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:15:20 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-wEmG9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:15:20 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-07Gxkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:15:20 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-iRu78K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:15:20 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-GiXidQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:15:20 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-rWHqFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:15:20 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-vPWQtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:15:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-uJEWON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:15:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-E8l_JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:15:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-iuNUrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:15:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Ta_g7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:15:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Q1SWYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-OX6t3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:15:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-vDx632-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:15:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-F821r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:15:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:15:21 INFO - Running setup.py install for manifestparser 04:15:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:15:22 INFO - Running setup.py install for mozcrash 04:15:22 INFO - Running setup.py install for mozdebug 04:15:22 INFO - Running setup.py install for mozdevice 04:15:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:15:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:15:22 INFO - Running setup.py install for mozfile 04:15:22 INFO - Running setup.py install for mozhttpd 04:15:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:15:22 INFO - Running setup.py install for mozinfo 04:15:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:15:22 INFO - Running setup.py install for mozInstall 04:15:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:15:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:15:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:15:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:15:23 INFO - Running setup.py install for mozleak 04:15:23 INFO - Running setup.py install for mozlog 04:15:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:15:23 INFO - Running setup.py install for moznetwork 04:15:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:15:23 INFO - Running setup.py install for mozprocess 04:15:23 INFO - Running setup.py install for mozprofile 04:15:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:15:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:15:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:15:23 INFO - Running setup.py install for mozrunner 04:15:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:15:24 INFO - Running setup.py install for mozscreenshot 04:15:24 INFO - Running setup.py install for moztest 04:15:24 INFO - Running setup.py install for mozversion 04:15:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:15:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:15:24 INFO - Cleaning up... 04:15:24 INFO - Return code: 0 04:15:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:24 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 0x103c4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7b14b82d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a28d30>, '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 0x10394fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a1dbe8>, '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.8GVdzmHmtq/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.E606IiTPXU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:15:24 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:15:24 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:15:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GVdzmHmtq/Render', 04:15:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:24 INFO - 'HOME': '/Users/cltbld', 04:15:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:24 INFO - 'LOGNAME': 'cltbld', 04:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:24 INFO - 'MOZ_NO_REMOTE': '1', 04:15:24 INFO - 'NO_EM_RESTART': '1', 04:15:24 INFO - 'PAGER': '/bin/cat', 04:15:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:24 INFO - 'PWD': '/builds/slave/test', 04:15:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:24 INFO - 'SHELL': '/bin/bash', 04:15:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E606IiTPXU/Listeners', 04:15:24 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 04:15:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:24 INFO - 'USER': 'cltbld', 04:15:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:24 INFO - 'XPC_FLAGS': '0x0', 04:15:24 INFO - 'XPC_SERVICE_NAME': '0', 04:15:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:15:24 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-pZy3Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:15:24 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:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:15:24 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ptMhh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:15:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-pyRfwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:15:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-0b9R2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:15:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-U6mr5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:15:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-RCtVcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:15:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ADJXNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:15:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-RPEezT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:15:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-apVyDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:15:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-OzCKDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:15:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-xNDNMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:15:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-UotubH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:15:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-cWZu3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:15:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-OzWzrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-_g8sTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:15:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-P618Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:15:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-tmti22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:15:26 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:15:26 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:15:26 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:15:26 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:15:26 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:15:26 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:15:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:15:26 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:15:26 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:15:26 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:15:26 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:15:26 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:15:26 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:15:27 INFO - Downloading blessings-1.6.tar.gz 04:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:15:28 INFO - Installing collected packages: blessings 04:15:28 INFO - Running setup.py install for blessings 04:15:28 INFO - Successfully installed blessings 04:15:28 INFO - Cleaning up... 04:15:28 INFO - Return code: 0 04:15:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:15:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:28 INFO - Reading from file tmpfile_stdout 04:15:28 INFO - Current package versions: 04:15:28 INFO - blessings == 1.6 04:15:28 INFO - blobuploader == 1.2.4 04:15:28 INFO - docopt == 0.6.1 04:15:28 INFO - functools32 == 3.2.3-2 04:15:28 INFO - jsonschema == 2.5.1 04:15:28 INFO - manifestparser == 1.1 04:15:28 INFO - mozInstall == 1.12 04:15:28 INFO - mozcrash == 1.0 04:15:28 INFO - mozdebug == 0.1 04:15:28 INFO - mozdevice == 0.49 04:15:28 INFO - mozfile == 1.2 04:15:28 INFO - mozhttpd == 0.7 04:15:28 INFO - mozinfo == 0.9 04:15:28 INFO - mozleak == 0.1 04:15:28 INFO - mozlog == 3.4 04:15:28 INFO - moznetwork == 0.27 04:15:28 INFO - mozprocess == 0.25 04:15:28 INFO - mozprofile == 0.28 04:15:28 INFO - mozrunner == 6.13 04:15:28 INFO - mozscreenshot == 0.1 04:15:28 INFO - mozsystemmonitor == 0.3 04:15:28 INFO - moztest == 0.8 04:15:28 INFO - mozversion == 1.4 04:15:28 INFO - psutil == 3.1.1 04:15:28 INFO - requests == 1.2.3 04:15:28 INFO - wsgiref == 0.1.2 04:15:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:28 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 0x103c4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7b14b82d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a28d30>, '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 0x10394fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a1dbe8>, '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.8GVdzmHmtq/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.E606IiTPXU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:15:28 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:15:28 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:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GVdzmHmtq/Render', 04:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:28 INFO - 'HOME': '/Users/cltbld', 04:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:28 INFO - 'LOGNAME': 'cltbld', 04:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:28 INFO - 'MOZ_NO_REMOTE': '1', 04:15:28 INFO - 'NO_EM_RESTART': '1', 04:15:28 INFO - 'PAGER': '/bin/cat', 04:15:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:28 INFO - 'PWD': '/builds/slave/test', 04:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:28 INFO - 'SHELL': '/bin/bash', 04:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E606IiTPXU/Listeners', 04:15:28 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 04:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:28 INFO - 'USER': 'cltbld', 04:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:28 INFO - 'XPC_FLAGS': '0x0', 04:15:28 INFO - 'XPC_SERVICE_NAME': '0', 04:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 INFO - Cleaning up... 04:15:28 INFO - Return code: 0 04:15:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:28 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 0x103c4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7b14b82d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a28d30>, '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 0x10394fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a1dbe8>, '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.8GVdzmHmtq/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.E606IiTPXU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:15:28 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:15:28 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:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GVdzmHmtq/Render', 04:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:28 INFO - 'HOME': '/Users/cltbld', 04:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:28 INFO - 'LOGNAME': 'cltbld', 04:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:28 INFO - 'MOZ_NO_REMOTE': '1', 04:15:28 INFO - 'NO_EM_RESTART': '1', 04:15:28 INFO - 'PAGER': '/bin/cat', 04:15:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:28 INFO - 'PWD': '/builds/slave/test', 04:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:28 INFO - 'SHELL': '/bin/bash', 04:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E606IiTPXU/Listeners', 04:15:28 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 04:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:28 INFO - 'USER': 'cltbld', 04:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:28 INFO - 'XPC_FLAGS': '0x0', 04:15:28 INFO - 'XPC_SERVICE_NAME': '0', 04:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:15:29 INFO - Cleaning up... 04:15:29 INFO - Return code: 0 04:15:29 INFO - Running post-action listener: _resource_record_post_action 04:15:29 INFO - Running post-action listener: _start_resource_monitoring 04:15:29 INFO - Starting resource monitoring. 04:15:29 INFO - [mozharness: 2017-05-03 11:15:29.204714Z] Finished create-virtualenv step (success) 04:15:29 INFO - [mozharness: 2017-05-03 11:15:29.205725Z] Running install step. 04:15:29 INFO - Running pre-action listener: _resource_record_pre_action 04:15:29 INFO - Running main action method: install 04:15:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:29 INFO - Reading from file tmpfile_stdout 04:15:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:15:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:15:29 INFO - Reading from file tmpfile_stdout 04:15:29 INFO - Output received: 04:15:29 INFO - Usage: mozinstall [options] installer 04:15:29 INFO - Options: 04:15:29 INFO - -h, --help show this help message and exit 04:15:29 INFO - -d DEST, --destination=DEST 04:15:29 INFO - Directory to install application into. [default: 04:15:29 INFO - "/builds/slave/test"] 04:15:29 INFO - --app=APP Application being installed. [default: firefox] 04:15:29 INFO - mkdir: /builds/slave/test/build/application 04:15:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:15:44 INFO - Reading from file tmpfile_stdout 04:15:44 INFO - Output received: 04:15:44 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:15:44 INFO - Running post-action listener: _resource_record_post_action 04:15:44 INFO - [mozharness: 2017-05-03 11:15:44.746777Z] Finished install step (success) 04:15:44 INFO - [mozharness: 2017-05-03 11:15:44.746899Z] Running run-tests step. 04:15:44 INFO - Running pre-action listener: _resource_record_pre_action 04:15:44 INFO - Running main action method: run_tests 04:15:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:15:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:15:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:15:44 INFO - 2017-05-03 04:15:44.761 screenresolution[1623:7339] starting screenresolution argv=screenresolution get 04:15:44 INFO - 2017-05-03 04:15:44.764 screenresolution[1623:7339] Display 0: 1600x1200x32@60 04:15:44 INFO - 2017-05-03 04:15:44.770 screenresolution[1624:7341] starting screenresolution argv=screenresolution list 04:15:44 INFO - Available Modes on Display 0 04:15:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:15:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:15:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:15:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:15:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:15:45 INFO - Intel Iris: 04:15:45 INFO - Chipset Model: Intel Iris 04:15:45 INFO - Type: GPU 04:15:45 INFO - Bus: Built-In 04:15:45 INFO - VRAM (Dynamic, Max): 1536 MB 04:15:45 INFO - Vendor: Intel (0x8086) 04:15:45 INFO - Device ID: 0x0a2e 04:15:45 INFO - Revision ID: 0x0009 04:15:45 INFO - Displays: 04:15:45 INFO - Display: 04:15:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:15:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:15:45 INFO - Display Serial Number: 1600x1200 60 04:15:45 INFO - Main Display: Yes 04:15:45 INFO - Mirror: Off 04:15:45 INFO - Online: Yes 04:15:45 INFO - Rotation: Supported 04:15:45 INFO - Return code: 0 04:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:45 INFO - Python 2.7.3 04:15:45 INFO - Return code: 0 04:15:45 INFO - grabbing minidump binary from tooltool 04:15: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:15:45 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 0x103a28d30>, '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 0x10394fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a1dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:45 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:15:45 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:15:45 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:15:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:45 INFO - Return code: 0 04:15:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:15:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:45 INFO - ENV: RUST_BACKTRACE is now 1 04:15:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:15:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --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:15:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GVdzmHmtq/Render', 04:15:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:45 INFO - 'HOME': '/Users/cltbld', 04:15:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:45 INFO - 'LOGNAME': 'cltbld', 04:15:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:45 INFO - 'MOZ_NO_REMOTE': '1', 04:15:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:45 INFO - 'NO_EM_RESTART': '1', 04:15:45 INFO - 'PAGER': '/bin/cat', 04:15:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:45 INFO - 'PWD': '/builds/slave/test', 04:15:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:45 INFO - 'RUST_BACKTRACE': '1', 04:15:45 INFO - 'SHELL': '/bin/bash', 04:15:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E606IiTPXU/Listeners', 04:15:45 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 04:15:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:45 INFO - 'USER': 'cltbld', 04:15:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:45 INFO - 'XPC_FLAGS': '0x0', 04:15:45 INFO - 'XPC_SERVICE_NAME': '0', 04:15:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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:15:45 INFO - mozversion application_buildid: 20170503031721 04:15:45 INFO - mozversion application_changeset: bd2ab9d0d30dad50f82b530cdd6194ed07110ee0 04:15:45 INFO - mozversion application_display_name: Firefox 04:15:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:45 INFO - mozversion application_name: Firefox 04:15:45 INFO - mozversion application_remotingname: firefox 04:15:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:15:45 INFO - mozversion application_vendor: Mozilla 04:15:45 INFO - mozversion application_version: 54.0 04:15:45 INFO - mozversion platform_buildid: 20170503031721 04:15:45 INFO - mozversion platform_changeset: bd2ab9d0d30dad50f82b530cdd6194ed07110ee0 04:15:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:15:45 INFO - mozversion platform_version: 54.0 04:15:45 INFO - using testdate: 1493810145 04:15:45 INFO - actual date: 1493810145 04:15:45 INFO - starting webserver on 'localhost:49240' 04:15:45 INFO - SUITE-START | Running 2 tests 04:15:45 INFO - TEST-START | dromaeo_css 04:15:45 INFO - operating with platform_type : mac_ 04:15:45 INFO - Initialising browser for dromaeo_css test... 04:15:45 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpdd98Kj/profile http://localhost:49240/getInfo.html) 04:15:47 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 04:15:47 INFO - PROCESS | 1634 | colorDepth:24 04:15:47 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 04:15:47 INFO - PROCESS | 1634 | __metrics 04:15:47 INFO - PROCESS | 1634 | 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:15:47 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:15:48 INFO - TEST-INFO | 1634: exit 0 04:15:48 INFO - Browser initialized. 04:15:48 INFO - Running cycle 1/1 for dromaeo_css test... 04:15:48 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpdd98Kj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:00 INFO - PROCESS | 1637 | RSS: Main: 165404672 04:16:00 INFO - PROCESS | 1637 | 04:19:03 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 04:19:06 INFO - PROCESS | 1637 | RSS: Main: 366317568 04:19:06 INFO - PROCESS | 1637 | 04:22:09 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 04:22:09 INFO - PROCESS | 1637 | RSS: Main: 302972928 04:22:09 INFO - PROCESS | 1637 | 04:25:12 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 04:25:12 INFO - PROCESS | 1637 | RSS: Main: 294498304 04:25:12 INFO - PROCESS | 1637 | 04:28:15 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 04:28:15 INFO - PROCESS | 1637 | RSS: Main: 281718784 04:28:15 INFO - PROCESS | 1637 | 04:31:19 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 04:31:19 INFO - PROCESS | 1637 | RSS: Main: 275390464 04:31:19 INFO - PROCESS | 1637 | 04:34:23 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 04:34:23 INFO - PROCESS | 1637 | RSS: Main: 354996224 04:34:23 INFO - PROCESS | 1637 | 04:34:23 INFO - PROCESS | 1637 | __start_tp_report 04:34:23 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 04:34:23 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 04:34:23 INFO - PROCESS | 1637 | |i|pagename|runs| 04:34:23 INFO - PROCESS | 1637 | |0;dojo.html;3070.155707180525;3524.859005639773;3539.893803185905;3559.3415218184623;3559.661832125947;4355.04189078403;5807.332156801969;5989.251343582052;6027.638341699501;6171.47542458891;6081;6131;6156.322804491502;6163.137160797481;6175.228096487939;4463.794775410637;5370.3287089113865;5430.0768869292115;5508.724563771795;5525.972370138144;5278.551323137538;5291.153415453528;5342.439043900393;5359.892802143955;5567.248421463091;5379.892402151954;5384.111621582434;5385.542228910547;5390.407055223922;5396.676199428047;5369.033573956666;5379.354477462691;5386.730663466811;5391.703456309901;5397.865053373677;5208.947910520922;5325.680459172462;5329.706866122362;5331.706756128411;5362.758675859595;5996.97001514994;6003.939960600425;6007.189029481052;6009.128676341906;6015.699215039274;6299.748010079591;6321;6335.3981371769605;6336.46140078094;6336.904946425761;6479.384458476437;6489.610623362613;6494.772682956121;6499.447546958514;6500.414962653384;6133.938660613381;6165.383461653843;6169;6185.752569897199;6204.441600255998;6347.619142851444;6354.364563543609;6625.370589793962;6639.800805975732;6700.731970721165;6275.246970363494;6349.079383489368;6366.745330186741;6366.77716279928;6399.776007839796;6505.251896031922;6515;6523.608583485006;6534.509911756637;6537.738490460329;6270.905936410957;6421.775237866652;6421.940379837368;6423.518236132215;6436.903446448307;6253.062040693932;6312.147860038928;6355.968220158869;6356.4279214870885;6391.424771770563;5240.737963101829;5242.9213561796605;5245.973770131125;5248.868778280574;5273.604479664041;4455.532169122195;4644.744539050317;4647.604953578916;4653.95346046542;4684.063187362541;5998.190244317048;6009.789657361971;6062.545309101835;6193.225846769154;6245.594036387621;6290.433860952537;6291.465225455796;6308.905366419507;6336.112944187817;6343.524235682342;5248.921266181011;6213.912565301054;6239;6247.968760156261;6286.339934306923;5641.097424412074;5680.8863822723315;5684.687342196219;5684.772609095672;5698.31620205578;6409.743610255724;6411.5832470889245;6748.426383757239;6774.627395493295;6774.966125169342;6352.269489008823;6380.170577824853;6465.547411681137;6478.902816457663;6492.642904640101;6614.4708423325055;6660.83347916306;6666.633335166613;6673.432758215606;6722.428593569406;6402.327755585597;6407.935920640734;6408.519361047846;6447.194100737408;6450.161479007699;6282.120503129657;6350.142730731292;6412.839679007876;6436.259830119596;6552.803415897531;5239.528442440199;6374.394432529088;6408.198975128109;6408.775692850728;6413.35866413355;6311.810645680637;6314.242290925118;6318.968405157945;6374.298827129105;6406.135171751754;6118.43644382056;6123.526657168115;6301.338359472189;6367.3314301997625;6372.904406433814;6334.556581039283;6378.553501254868;6387.105805187184;6397.808065758035;6402.263739669997;6096.055111457731;6116.8836339025665;6359.04614307839;6360.141380913703;6374.713137908712 04:34:23 INFO - PROCESS | 1637 | |1;ext.html;802.9036515618126;831.0359982420391;886.9512176830276;888.307120446052;920.9401388909724;40235.59764402355;40858.59141408585;40860.59139408605;40881;40923.59076409231;38241.617583824154;38470;38502.61497385025;38514;38538;7877.2122787721055;7957.965464489623;8014.5591992440395;8094.190580941918;11596.826047609293;11710.355930423822;11836.704082397922;11846.052315814713;11866.94066529666;11899.821502677467;9867.60529578816;11857.22928009681;11860;11879.881201187964;11879.881201188007;11793.587224447147;11812.350320732356;11821.468033938494;11831.881681183164;11836.585719499863;11448.313101213955;11535.653930382103;11549.307041577533;11554.480048397758;11562.30626162433;39837.601623983675;40201.79899100515;40218.798906005286;40270;40337.19325613471;3978.8209530571194;4083.2241874044134;4090.6727461802984;4114.753114813091;4117.629413352783;28603.14190574286;29858.40283194346;30618.081457556087;30782.846085769652;30842;3123.7813353065294;3169.7464202863716;3197.488401855692;3203.0550987458755;3255.166399944506;366889;367486.3251367479;367874;367887.32112679066;368829;53328.933421332134;53424.198637020476;53460.73269633627;53505.464945350046;53585.46414535883;55149;55221.72389138109;55274;55326.51030703628;55349.61625959303;15265;15354.462593809163;15367.846321536865;15402.614934626725;15411.767058635282;13137.211767293993;13140.934295328461;13152.934235328763;13159.53941612039;13171.93414032943;10895.182861285435;11954.760904781855;11972.521099155936;12041.157119001586;12054.095942804324;5297.735113244323;5339.305890234323;5348.224507446398;5349.090654588651;5362.624616276823;752.450710980987;971.6647756523988;976.1361195342173;981.617169303972;1002.3134153105146;24105.638415423782;25673.10144144946;28346.574801377996;29020.854895725388;29067.56398654022;720.6108701301343;1094.5621751299384;1097.7475180708323;1180.2505409065134;1212.3453335198894;12760.744785104245;13459.93270033663;13506.392212350467;13530.729385412433;14814.62963425923;499610;501403;501974;502729;503925;49214.261786073235;49255.261171082464;49333.753331233114;49435.0112997738;49447.76380590442;1438.359929831236;1448.862358075981;1474.2333986327264;1491.6569189086354;1492.7611582147022;27228.40293036653;27269;28043.43913121767;28159.15522534327;28282.2929426766;40190;40616.78149655515;40649.79675101724;40667.7966610165;40707.59292407038;480588;481830.5908470575;482263;483922;484051;29299.853500733214;29420.55869162007;29428.705712943454;29653.110406687832;29867;40269;40314.39528407135;40630.39054414127;40832.3875141879;41375.7931210342;27109.78005989696;28064.85967570149;28429.573556397085;28564.0002599908;29983.550246746752;28499;28839.56740648934;28896.42207155803;29844.85077574598;29873.95441159549;33316.833910813;34394.82802585971;34506.65493345034;34664.13339666528;35159.64840351564;28688.13935581936;28733.706983185388;28902.42195156043;29259.41481170407;29763.553546696385;19543.120559575138;21912.937825536712;22165.445863853533;23012.654810178195;23093.53812923766 04:34:23 INFO - PROCESS | 1637 | |2;jquery.html;421.4226509681736;431.7888323253275;435.5535576034564;439.3958307327424;441.8608138436392;21348.146074157034;21736.456588585275;22344;22546;22925.77074229257;18992.525186870334;23071;23669;24376.87811560944;24639.384015399624;5453.918191227135;5880.294364676245;7057.188423331306;7099.325564071431;7121.611285799271;6118.847028824271;6949.861002779941;7009.684564194624;7112.964435177817;7124.786256412316;6687.465002799764;6962.443004559623;7023.122109736283;7029.578225306498;7128.821779455503;6726.697298621574;6931.965340173318;6968;7055.15338159419;7063.752768653072;6875.07186529817;6878.8624227515165;6880.174379074493;6881.965590172067;6882.070920425778;23352.766472335228;28098.157055288375;28350.432991340058;28551.714482855114;29090.12729618115;2747.2719729271757;2776.9028084016963;2886.985565072161;3080.676528964449;3134.8275844828527;16408.933419327706;16455.424060157955;16594.08732519711;16712.83287167125;16789.83210167895;2118.788121187869;2132.4668832791804;2133.777539810036;2160.7299087614047;2213.1147540983575;166292.16853915653;168882;170166;171072;173963;17002.829971700125;19494.512637184183;19584.21663133487;20530.38408847737;20596;32342.514862277083;32556.511652325233;32602.83698581492;32615.347693046006;32618.673813262038;9331.860022099674;9544.759181306386;10257.435841028666;10577.471126443646;10667.306625069346;9057.77355566116;9070.503366944513;9070.591823367964;9269.397489163182;9284.907150928404;9415.387999780129;9526;9615.375000624937;9617.326787124834;9634.90365096354;3727.2172843702583;3776.4524143998965;3783.4246636928387;3793.3551296279697;3796.734228603971;1032.3496197395593;1053.6206965492418;1054.4306074719718;1101.658485869383;1106.750981029262;20447;21921.232756853435;21925.780742192692;22021.22925697593;22099.67401955888;1016.7102375822855;1022.5756311130946;1041.5469270867197;1049.7480604654827;1052.2949623752104;10835.349879007284;11373.715657108638;11379.829302560469;11392.715182120348;11408.771824563462;785870;793308;798635;803490;824495;115826;147144;154070;154448.22775886275;154635;1206.4028305988593;1219.481720268882;1247.7504499100035;1250.3685638752372;1254.6298841841678;18275.54311142179;19038;19072.237110515423;19101.617967640846;19177.80822191816;47395;62173.37826621857;62750.37249627628;63118.36881631309;64296.67851660899;86189.1381086181;86677;88421.55789221013;89329.55335223282;90089.54955225182;7672.846543069219;9599.520023998632;11398.544058237578;11654.475548600163;11942.641720748392;11113.944430277797;13059.738805223653;13230.007749418639;13416.932915335361;13601.727965440437;10931;11344.943275283571;11503.942480287546;11585.304881706787;11806.645800625995;9835.967223441436;10595.735106622396;10604.098651614391;10638.308509946828;10958.452077396258;9843.360181588174;10771.892281077402;11723.648290551297;11878.940605296919;11935.283882967049;11697.356645384585;11837.46731397072;12058.75882482363;12072.577459788865;12076.939615302219;9666.709998700051;9930.25523085757;9955.800883982134;9962.203023757937;9996.200303975518 04:34:23 INFO - PROCESS | 1637 | |3;mootools.html;1413.5547302599687;1615.741481362982;1627.2351994562553;1639.1558347451062;1642.334854383975;9500;9910.008999100086;11229.213955023151;11480.885191148085;11791.764164716722;11300.604478843243;11397.487113079911;11399.544018239261;11421.657350279484;11422.485988130533;2480.057578120316;2542.707588627313;2547.2103647869126;2550.1584477122506;2551.260134560984;2138.8823614701187;2208.8232941364654;2211.8009379155874;2220.145244081032;2221.9888900555475;2116.7459904811444;2165.4369863835436;2424.6363045543135;2513.0450428837016;2529.53203657324;2494.650748895156;2516.584763514027;2518.5718427867305;2521.420073383132;2528.190978886757;2493.7506249375097;2496.700395952479;2497.7377375375686;2500.274920273119;2500.362407586072;11327.716807079807;11460.426978651034;11476.655700329004;11511.769764604662;11622.128340374506;6026.427489388501;6193.907091393633;6203.8138855834395;6209.2548894133;6217.409346112112;3542.4863394807608;3672.137047793766;3832.9233415331814;3857.517810273716;3904.472896159039;1181.5805389086922;1198.1493139870702;1216.9817452738216;1255.2593969558004;1261.4197469164196;15194.620134496616;16171.029738215744;16202.83797162025;16207.270672819752;16215.432459863967;4426.849019255017;4851.288700298593;5060.139776238048;5102.591792656579;5184.5593124584075;13277.402516886763;13309;13313.46746130144;13314.400851961685;13347.799783003262;6177.69111544421;6283.685815709287;6284.371562843679;6296.150019747367;6312.116303717483;5387.784488620489;5491.615586908878;5553.305836770403;5569.972150139304;5664.830055098354;3807.5430948286385;4123.4021066945725;4220.599043090963;4241.91516169681;4283.657307415399;960.2222200018008;1075.4031512510633;1156.1329003247565;1186.8753780853058;1193.5345215366015;978.8042391521724;979.9687244024099;987;988.5057471264367;1009.8081364540714;5859.20900678403;6743.123393958754;6875.518713689994;7059.89410158848;7084.681189346492;837.8198687282263;1068.513826209073;1083.978320433587;1090.7164137324194;1092.808758467265;3813.542374915028;3834.6740527055513;4356.041670832412;4408.6913916026215;4431.645468362523;13795.724085518234;14315.355808988621;14363.56909292702;14373.353199106064;14374.85625143756;13996.300184990914;14237.85762142386;14256.501022464372;14285.928570357082;14304.427822887175;10601.522931468102;10784.460776961121;10790.406527641055;10812;10817.729556761144;6831.795046148623;6888.586684798928;6945.236024037251;6957.756478523227;6979.255186203449;12343.75312493763;12612.306323151948;12820.871791282341;12821.807672885101;12966.870331296566;12898.80651790205;13026.804597931228;13060.869391305965;13124.671883202996;13358.866411335763;9340.71977840666;9419.670311539063;9486.478243696663;9519.714408567754;9556.85664715016;10345.793084138124;10504.894951050697;10577.735556610838;10602.946985265333;10628.36229826213;7087.184973728087;8710.782230444289;9075.773105672411;9087.59105840252;9109.089091091102;8366.498010119412;8560;8636.00685921102;8688.174623410765;8856.734297971072;7935.722249721232;8008.359331253602;8048.557329346942;8154.592270386575;8161.836763264582;5897.174395584536;5995.5803093783015;6158.291796443287;6244;6263.843403914939;5973.253343332083;6032.788852390146;6148.78479253224;6181.81454556364;6280.937190628035 04:34:23 INFO - PROCESS | 1637 | |4;prototype.html;333.8280785395521;388.1189699382402;388.4891367851277;395.8693631101735;396.60537764923896;4179.895502612436;4646.279826626878;4797.256425254087;4980.825671101512;5018.723970181643;4481.641468682497;4590.563896429834;4923.458419573844;4987;5000.874978125548;3276;3849.461075449425;3931.842726290945;4179.707420480568;4195.077083041741;3374.2285300217336;3595.5347871235836;4167.979160104211;4198.076423186894;4224.239636865363;3499.982500087496;3652.7990960497164;3860.7104467164936;4192.496900371944;4265.488141423034;3816.637419445148;4006;4086.420862411515;4188.371744238359;4219.578042195772;3284.3232765296207;3851.4030325299623;3860.3244432224246;3877.9030524236837;3917.8824635260703;4448.933266001012;4498.280275155959;4514.8419805306985;4868.440129385131;4916.4188800879465;4880.389951256093;4882.438519570223;4912.606991440676;4928.6303527235605;4942.676941837331;4940.55535001848;5028.296038554606;5340.928965844655;5386.515213630752;5392.274472168908;3814.7030009796526;4193.308104162809;4332.371806088131;4338.652907767371;4371.803268852909;4552.180607490651;4995.000999800018;5027.622928280357;5111.795528178868;5544;3781.470594116826;4199.601037901394;4267.829286828554;4378.8762450211625;4407.920059585422;3947.4078888167005;4016.136530645925;4176.227397931331;4361.956380436155;4461.739039217539;4406.361077643788;4740.502247263988;4749.4775574686755;4862.41651001882;4938.913439043405;4781.306710526954;5118.59051275897;5347.278117454094;5390.67655940637;5413.891722165614;1281.35932033983;1509.8943073984935;1522.6421790879135;1524.764940398281;1538.361579944333;1022.8721409823772;1072.9624463143753;1099.2689861242184;1153.7501871350732;1169.450478116499;4608.746518941423;4737.763111844394;4766.71197825046;4773.474917759044;5147.455763271004;4654.208129869957;4824.333506535058;5208.84373468789;5372.179605707035;5534.252875861707;4337.392765012901;4668.5564871337165;4908.9754551227015;5151.871203219875;5210.296609957683;2316.5945959457026;2597.9350516237246;2702.513547561458;2835.560488124344;2851.0734011445948;5732.942670573241;5747.568932330092;5758.942410575841;5767.183337248754;5779.450952159538;4532.841350552781;5332.173513105475;5575.749091290821;5681.375048744635;5687.241687781423;4683.414573178353;4757.9532502849315;4970.751462426864;5429.995450841607;5496.31296087989;4868.853934381974;4955.554000140005;5132.461091585479;5228.738563071755;5353.678779273256;4818.445878723992;5049.601439316295;5431.306711436261;5446.509814116748;5476.835694929158;5023.748812559431;5662.348829884616;5730.914036289542;5742.397048309867;5749.051406518045;3649.489071529935;3979.6668116181404;4082.9785958389984;4434.782608695652;4531.660125490667;4978.8755281118265;5114.872128196825;5151.433342332415;5500.477454641803;5692.772289108555;4618.953810461987;4847.151748443937;5399.676019438846;5429.511343979061;5491.512889315234;4624.5375462453485;4721.598664113451;5347.385050719217;5446.373667028342;5461.781528738806;4377.1683380157665;4940.863601371633;5070.442251352422;5308.840734777963;5317.494837990384;5061.936993231463;5101.724568857786;5396.676199428047;5408.864778380572;5438.918416223839;5077.8730531737;5292.655977361459;5302.681839089667;5343.492368225013;5343.9465605345 04:34:23 INFO - PROCESS | 1637 | |5;yui.html;789.6328207383569;817.7056259746487;832.196929962586;893.584483215305;905.3164860530301;16311.673766524662;17250.82749172508;17255.741163882536;17271.654566908655;17275.74086388705;15750.763738543903;15955.202239888018;15984.040957542555;15993.360265589363;16012.919935400336;778.4900889917113;959.8704174936399;961.0965692249264;961.4471678784691;978.2711879649671;983.2772911909741;987.521052289639;992.0278127435118;993.3642468819961;1019.6125472320508;1057.8994995475418;1058.3279617442902;1058.6559368205326;1059.1685526861415;1061.0079575596842;1055.4247934875511;1055.4617145255897;1055.5566662001977;1056.287006270764;1057.228223396917;785.2187073861487;785.654312102673;785.8231897823001;786.0371045469254;787.2127872127872;16048.83951160485;16285.02289862612;16311.265993030342;17413.955162690152;17434.215460304316;14561.053531520418;14775.778363324558;14831.851681483155;14845.257737113208;14861.479848205368;12117.091218158674;12198.756024879542;12216.572419965258;12278.140530162893;12538.561150359785;3764.698824094066;3852.7880966546827;3863.4011728182177;3892.4939757831585;4021.7586944783407;119947;122091.55816883613;122129;122277.77722222752;125618;11174.832377514344;11509.827352589718;11665.76668466626;11733.35466549348;11924.284542927453;24215;24511.632325515133;25113;25144.371390715012;25146.74853251444;8126.553039582762;8144.75565733029;8189.590520473953;8229.876551851727;8331.208535189147;3989.2819292527042;4455.22033644111;4549.566886430764;4724.126036683225;4802.711837289774;3556.075420390717;3674.65090816372;3676.0809797550614;3680.8895733128047;3682.3924052531033;648.3937518420292;682.4199430484049;685.5509641185032;686.4371215603157;688.5765254368628;587.8383444552783;666.3436515032689;667.8096742428385;696.4637229333385;700.3801635552572;8821.558922053871;9976.351537150062;9986.400815951067;10048.397096174253;10168.33905796121;661.9304972977865;667.8864593019198;683.5767205257374;706.780897921646;722.8590424867206;4360.41134446852;4872.731999739977;4901.803927842918;4932.605391568738;4946.802127914843;97330.51334743423;107035;107248;108024;109739.45130274458;90071.54964225137;92524.53737731268;93188;93294.13411731727;94283;82959.17040829636;84715.57642211749;85018.57490712508;85115.5744221275;85193.14806851852;9680.419174849532;9688.75778105553;9689.660861869801;9721.805563888824;9767.609295628095;51174.74412627913;53537.73231133819;54526.72736636292;56188.719056406095;56697.73209071591;63685.6815715937;68467.97298040433;70242.64878675574;70551.29448705447;70678;11644.301341919512;11744.647660570197;12018.098642601664;12363;12463.937680311541;12307.69230769238;12690.492380304684;12712.792284732936;12864;13126.60620181396;11590.42047897585;11622.6513204604;12172.2696638202;12391.318477483464;12431.782259908332;11672.299662020307;11999.700007499883;12005.279683219034;12167.817482737943;12419.659829170148;11340.149488788209;11766.411679416165;11870.525178992744;12021.519139234682;12113.81829272544;8785.736427907173;8856.3800533962;8983.236424903957;9172.6789562365;9291.86062209081;8764.21122099014;9926.928980532677;9939.462618912805;9943.648333657813;9953.353032052893 04:34:23 INFO - PROCESS | 1637 | __end_tp_report 04:34:23 INFO - PROCESS | 1637 | __start_cc_report 04:34:23 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,2224 04:34:23 INFO - PROCESS | 1637 | __end_cc_report 04:34:23 INFO - PROCESS | 1637 | __startTimestamp1493811263515__endTimestamp 04:34:23 INFO - PROCESS | 1637 | 04:34:23 INFO - PROCESS | 1637 | ------- Summary: start ------- 04:34:23 INFO - PROCESS | 1637 | Number of tests: 6 04:34:23 INFO - PROCESS | 1637 | 04:34:23 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5972.25 Median:6282.12 stddev:692.87 (11.0%) stddev-sans-first:656.53 04:34:23 INFO - PROCESS | 1637 | Values: 3070.2 3524.9 3539.9 3559.3 3559.7 4355.0 5807.3 5989.3 6027.6 6171.5 6081.0 6131.0 6156.3 6163.1 6175.2 4463.8 5370.3 5430.1 5508.7 5526.0 5278.6 5291.2 5342.4 5359.9 5567.2 5379.9 5384.1 5385.5 5390.4 5396.7 5369.0 5379.4 5386.7 5391.7 5397.9 5208.9 5325.7 5329.7 5331.7 5362.8 5997.0 6003.9 6007.2 6009.1 6015.7 6299.7 6321.0 6335.4 6336.5 6336.9 6479.4 6489.6 6494.8 6499.4 6500.4 6133.9 6165.4 6169.0 6185.8 6204.4 6347.6 6354.4 6625.4 6639.8 6700.7 6275.2 6349.1 6366.7 6366.8 6399.8 6505.3 6515.0 6523.6 6534.5 6537.7 6270.9 6421.8 6421.9 6423.5 6436.9 6253.1 6312.1 6356.0 6356.4 6391.4 5240.7 5242.9 5246.0 5248.9 5273.6 4455.5 4644.7 4647.6 4654.0 4684.1 5998.2 6009.8 6062.5 6193.2 6245.6 6290.4 6291.5 6308.9 6336.1 6343.5 5248.9 6213.9 6239.0 6248.0 6286.3 5641.1 5680.9 5684.7 5684.8 5698.3 6409.7 6411.6 6748.4 6774.6 6775.0 6352.3 6380.2 6465.5 6478.9 6492.6 6614.5 6660.8 6666.6 6673.4 6722.4 6402.3 6407.9 6408.5 6447.2 6450.2 6282.1 6350.1 6412.8 6436.3 6552.8 5239.5 6374.4 6408.2 6408.8 6413.4 6311.8 6314.2 6319.0 6374.3 6406.1 6118.4 6123.5 6301.3 6367.3 6372.9 6334.6 6378.6 6387.1 6397.8 6402.3 6096.1 6116.9 6359.0 6360.1 6374.7 04:34:23 INFO - PROCESS | 1637 | 04:34:23 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:58191.96 Median:3146.76 stddev:120917.05 (3842.6%) stddev-sans-first:121179.48 04:34:23 INFO - PROCESS | 1637 | Values: 802.9 831.0 887.0 888.3 920.9 40235.6 40858.6 40860.6 40881.0 40923.6 38241.6 38470.0 38502.6 38514.0 38538.0 7877.2 7958.0 8014.6 8094.2 11596.8 11710.4 11836.7 11846.1 11866.9 11899.8 9867.6 11857.2 11860.0 11879.9 11879.9 11793.6 11812.4 11821.5 11831.9 11836.6 11448.3 11535.7 11549.3 11554.5 11562.3 39837.6 40201.8 40218.8 40270.0 40337.2 3978.8 4083.2 4090.7 4114.8 4117.6 28603.1 29858.4 30618.1 30782.8 30842.0 3123.8 3169.7 3197.5 3203.1 3255.2 366889.0 367486.3 367874.0 367887.3 368829.0 53328.9 53424.2 53460.7 53505.5 53585.5 55149.0 55221.7 55274.0 55326.5 55349.6 15265.0 15354.5 15367.8 15402.6 15411.8 13137.2 13140.9 13152.9 13159.5 13171.9 10895.2 11954.8 11972.5 12041.2 12054.1 5297.7 5339.3 5348.2 5349.1 5362.6 752.5 971.7 976.1 981.6 1002.3 24105.6 25673.1 28346.6 29020.9 29067.6 720.6 1094.6 1097.7 1180.3 1212.3 12760.7 13459.9 13506.4 13530.7 14814.6 499610.0 501403.0 501974.0 502729.0 503925.0 49214.3 49255.3 49333.8 49435.0 49447.8 1438.4 1448.9 1474.2 1491.7 1492.8 27228.4 27269.0 28043.4 28159.2 28282.3 40190.0 40616.8 40649.8 40667.8 40707.6 480588.0 481830.6 482263.0 483922.0 484051.0 29299.9 29420.6 29428.7 29653.1 29867.0 40269.0 40314.4 40630.4 40832.4 41375.8 27109.8 28064.9 28429.6 28564.0 29983.6 28499.0 28839.6 28896.4 29844.9 29874.0 33316.8 34394.8 34506.7 34664.1 35159.6 28688.1 28733.7 28902.4 29259.4 29763.6 19543.1 21912.9 22165.4 23012.7 23093.5 04:34:23 INFO - PROCESS | 1637 | 04:34:23 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:44767.19 Median:23211.88 stddev:133434.96 (574.9%) stddev-sans-first:133767.73 04:34:23 INFO - PROCESS | 1637 | Values: 421.4 431.8 435.6 439.4 441.9 21348.1 21736.5 22344.0 22546.0 22925.8 18992.5 23071.0 23669.0 24376.9 24639.4 5453.9 5880.3 7057.2 7099.3 7121.6 6118.8 6949.9 7009.7 7113.0 7124.8 6687.5 6962.4 7023.1 7029.6 7128.8 6726.7 6932.0 6968.0 7055.2 7063.8 6875.1 6878.9 6880.2 6882.0 6882.1 23352.8 28098.2 28350.4 28551.7 29090.1 2747.3 2776.9 2887.0 3080.7 3134.8 16408.9 16455.4 16594.1 16712.8 16789.8 2118.8 2132.5 2133.8 2160.7 2213.1 166292.2 168882.0 170166.0 171072.0 173963.0 17002.8 19494.5 19584.2 20530.4 20596.0 32342.5 32556.5 32602.8 32615.3 32618.7 9331.9 9544.8 10257.4 10577.5 10667.3 9057.8 9070.5 9070.6 9269.4 9284.9 9415.4 9526.0 9615.4 9617.3 9634.9 3727.2 3776.5 3783.4 3793.4 3796.7 1032.3 1053.6 1054.4 1101.7 1106.8 20447.0 21921.2 21925.8 22021.2 22099.7 1016.7 1022.6 1041.5 1049.7 1052.3 10835.3 11373.7 11379.8 11392.7 11408.8 785870.0 793308.0 798635.0 803490.0 824495.0 115826.0 147144.0 154070.0 154448.2 154635.0 1206.4 1219.5 1247.8 1250.4 1254.6 18275.5 19038.0 19072.2 19101.6 19177.8 47395.0 62173.4 62750.4 63118.4 64296.7 86189.1 86677.0 88421.6 89329.6 90089.5 7672.8 9599.5 11398.5 11654.5 11942.6 11113.9 13059.7 13230.0 13416.9 13601.7 10931.0 11344.9 11503.9 11585.3 11806.6 9836.0 10595.7 10604.1 10638.3 10958.5 9843.4 10771.9 11723.6 11878.9 11935.3 11697.4 11837.5 12058.8 12072.6 12076.9 9666.7 9930.3 9955.8 9962.2 9996.2 04:34:23 INFO - PROCESS | 1637 | 04:34:23 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:7004.91 Median:2524.81 stddev:4422.44 (175.2%) stddev-sans-first:4414.88 04:34:23 INFO - PROCESS | 1637 | Values: 1413.6 1615.7 1627.2 1639.2 1642.3 9500.0 9910.0 11229.2 11480.9 11791.8 11300.6 11397.5 11399.5 11421.7 11422.5 2480.1 2542.7 2547.2 2550.2 2551.3 2138.9 2208.8 2211.8 2220.1 2222.0 2116.7 2165.4 2424.6 2513.0 2529.5 2494.7 2516.6 2518.6 2521.4 2528.2 2493.8 2496.7 2497.7 2500.3 2500.4 11327.7 11460.4 11476.7 11511.8 11622.1 6026.4 6193.9 6203.8 6209.3 6217.4 3542.5 3672.1 3832.9 3857.5 3904.5 1181.6 1198.1 1217.0 1255.3 1261.4 15194.6 16171.0 16202.8 16207.3 16215.4 4426.8 4851.3 5060.1 5102.6 5184.6 13277.4 13309.0 13313.5 13314.4 13347.8 6177.7 6283.7 6284.4 6296.2 6312.1 5387.8 5491.6 5553.3 5570.0 5664.8 3807.5 4123.4 4220.6 4241.9 4283.7 960.2 1075.4 1156.1 1186.9 1193.5 978.8 980.0 987.0 988.5 1009.8 5859.2 6743.1 6875.5 7059.9 7084.7 837.8 1068.5 1084.0 1090.7 1092.8 3813.5 3834.7 4356.0 4408.7 4431.6 13795.7 14315.4 14363.6 14373.4 14374.9 13996.3 14237.9 14256.5 14285.9 14304.4 10601.5 10784.5 10790.4 10812.0 10817.7 6831.8 6888.6 6945.2 6957.8 6979.3 12343.8 12612.3 12820.9 12821.8 12966.9 12898.8 13026.8 13060.9 13124.7 13358.9 9340.7 9419.7 9486.5 9519.7 9556.9 10345.8 10504.9 10577.7 10602.9 10628.4 7087.2 8710.8 9075.8 9087.6 9109.1 8366.5 8560.0 8636.0 8688.2 8856.7 7935.7 8008.4 8048.6 8154.6 8161.8 5897.2 5995.6 6158.3 6244.0 6263.8 5973.3 6032.8 6148.8 6181.8 6280.9 04:34:23 INFO - PROCESS | 1637 | 04:34:23 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4422.18 Median:4789.28 stddev:1242.87 (26.0%) stddev-sans-first:1207.88 04:34:23 INFO - PROCESS | 1637 | Values: 333.8 388.1 388.5 395.9 396.6 4179.9 4646.3 4797.3 4980.8 5018.7 4481.6 4590.6 4923.5 4987.0 5000.9 3276.0 3849.5 3931.8 4179.7 4195.1 3374.2 3595.5 4168.0 4198.1 4224.2 3500.0 3652.8 3860.7 4192.5 4265.5 3816.6 4006.0 4086.4 4188.4 4219.6 3284.3 3851.4 3860.3 3877.9 3917.9 4448.9 4498.3 4514.8 4868.4 4916.4 4880.4 4882.4 4912.6 4928.6 4942.7 4940.6 5028.3 5340.9 5386.5 5392.3 3814.7 4193.3 4332.4 4338.7 4371.8 4552.2 4995.0 5027.6 5111.8 5544.0 3781.5 4199.6 4267.8 4378.9 4407.9 3947.4 4016.1 4176.2 4362.0 4461.7 4406.4 4740.5 4749.5 4862.4 4938.9 4781.3 5118.6 5347.3 5390.7 5413.9 1281.4 1509.9 1522.6 1524.8 1538.4 1022.9 1073.0 1099.3 1153.8 1169.5 4608.7 4737.8 4766.7 4773.5 5147.5 4654.2 4824.3 5208.8 5372.2 5534.3 4337.4 4668.6 4909.0 5151.9 5210.3 2316.6 2597.9 2702.5 2835.6 2851.1 5732.9 5747.6 5758.9 5767.2 5779.5 4532.8 5332.2 5575.7 5681.4 5687.2 4683.4 4758.0 4970.8 5430.0 5496.3 4868.9 4955.6 5132.5 5228.7 5353.7 4818.4 5049.6 5431.3 5446.5 5476.8 5023.7 5662.3 5730.9 5742.4 5749.1 3649.5 3979.7 4083.0 4434.8 4531.7 4978.9 5114.9 5151.4 5500.5 5692.8 4619.0 4847.2 5399.7 5429.5 5491.5 4624.5 4721.6 5347.4 5446.4 5461.8 4377.2 4940.9 5070.4 5308.8 5317.5 5061.9 5101.7 5396.7 5408.9 5438.9 5077.9 5292.7 5302.7 5343.5 5343.9 04:34:23 INFO - PROCESS | 1637 | 04:34:23 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:21488.31 Median:3940.89 stddev:31813.66 (807.3%) stddev-sans-first:31864.94 04:34:23 INFO - PROCESS | 1637 | Values: 789.6 817.7 832.2 893.6 905.3 16311.7 17250.8 17255.7 17271.7 17275.7 15750.8 15955.2 15984.0 15993.4 16012.9 778.5 959.9 961.1 961.4 978.3 983.3 987.5 992.0 993.4 1019.6 1057.9 1058.3 1058.7 1059.2 1061.0 1055.4 1055.5 1055.6 1056.3 1057.2 785.2 785.7 785.8 786.0 787.2 16048.8 16285.0 16311.3 17414.0 17434.2 14561.1 14775.8 14831.9 14845.3 14861.5 12117.1 12198.8 12216.6 12278.1 12538.6 3764.7 3852.8 3863.4 3892.5 4021.8 119947.0 122091.6 122129.0 122277.8 125618.0 11174.8 11509.8 11665.8 11733.4 11924.3 24215.0 24511.6 25113.0 25144.4 25146.7 8126.6 8144.8 8189.6 8229.9 8331.2 3989.3 4455.2 4549.6 4724.1 4802.7 3556.1 3674.7 3676.1 3680.9 3682.4 648.4 682.4 685.6 686.4 688.6 587.8 666.3 667.8 696.5 700.4 8821.6 9976.4 9986.4 10048.4 10168.3 661.9 667.9 683.6 706.8 722.9 4360.4 4872.7 4901.8 4932.6 4946.8 97330.5 107035.0 107248.0 108024.0 109739.5 90071.5 92524.5 93188.0 93294.1 94283.0 82959.2 84715.6 85018.6 85115.6 85193.1 9680.4 9688.8 9689.7 9721.8 9767.6 51174.7 53537.7 54526.7 56188.7 56697.7 63685.7 68468.0 70242.6 70551.3 70678.0 11644.3 11744.6 12018.1 12363.0 12463.9 12307.7 12690.5 12712.8 12864.0 13126.6 11590.4 11622.7 12172.3 12391.3 12431.8 11672.3 11999.7 12005.3 12167.8 12419.7 11340.1 11766.4 11870.5 12021.5 12113.8 8785.7 8856.4 8983.2 9172.7 9291.9 8764.2 9926.9 9939.5 9943.6 9953.4 04:34:23 INFO - PROCESS | 1637 | -------- Summary: end -------- 04:34:23 INFO - PROCESS | 1637 | 04:34:24 INFO - TEST-INFO | 1637: exit 0 04:34:24 INFO - TEST-OK | dromaeo_css | took 1118771ms 04:34:24 INFO - TEST-START | kraken 04:34:24 INFO - operating with platform_type : mac_ 04:34:24 INFO - Initialising browser for kraken test... 04:34:24 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmp8cPBD6/profile http://localhost:49240/getInfo.html) 04:34:26 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 04:34:26 INFO - PROCESS | 1647 | colorDepth:24 04:34:26 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 04:34:26 INFO - PROCESS | 1647 | __metrics 04:34:26 INFO - PROCESS | 1647 | 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:34:26 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:34:27 INFO - TEST-INFO | 1647: exit 0 04:34:27 INFO - Browser initialized. 04:34:27 INFO - Running cycle 1/1 for kraken test... 04:34:27 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmp8cPBD6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:39 INFO - PROCESS | 1649 | RSS: Main: 165429248 04:34:39 INFO - PROCESS | 1649 | 04:34:42 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:43 INFO - PROCESS | 1649 | RSS: Main: 215990272 04:34:43 INFO - PROCESS | 1649 | 04:34:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 04:34:46 INFO - PROCESS | 1649 | RSS: Main: 231194624 04:34:46 INFO - PROCESS | 1649 | 04:34:49 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 04:34:50 INFO - PROCESS | 1649 | RSS: Main: 329400320 04:34:50 INFO - PROCESS | 1649 | 04:34:52 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 04:34:52 INFO - PROCESS | 1649 | RSS: Main: 230391808 04:34:52 INFO - PROCESS | 1649 | 04:34:54 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:55 INFO - PROCESS | 1649 | RSS: Main: 231833600 04:34:55 INFO - PROCESS | 1649 | 04:34:58 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:58 INFO - PROCESS | 1649 | RSS: Main: 272322560 04:34:58 INFO - PROCESS | 1649 | 04:35:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 04:35:02 INFO - PROCESS | 1649 | RSS: Main: 273199104 04:35:02 INFO - PROCESS | 1649 | 04:35:05 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 04:35:06 INFO - PROCESS | 1649 | RSS: Main: 272113664 04:35:06 INFO - PROCESS | 1649 | 04:35:07 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:35:08 INFO - PROCESS | 1649 | RSS: Main: 248602624 04:35:08 INFO - PROCESS | 1649 | 04:35:10 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:35:10 INFO - PROCESS | 1649 | RSS: Main: 250265600 04:35:10 INFO - PROCESS | 1649 | 04:35:13 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:35:13 INFO - PROCESS | 1649 | RSS: Main: 255733760 04:35:13 INFO - PROCESS | 1649 | 04:35:16 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:35:17 INFO - PROCESS | 1649 | RSS: Main: 272150528 04:35:17 INFO - PROCESS | 1649 | 04:35:20 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:35:20 INFO - PROCESS | 1649 | RSS: Main: 265809920 04:35:20 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 04:35:22 INFO - PROCESS | 1649 | RSS: Main: 310800384 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | __start_tp_report 04:35:22 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 04:35:22 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 04:35:22 INFO - PROCESS | 1649 | |i|pagename|runs| 04:35:22 INFO - PROCESS | 1649 | |0;ai-astar;105;114;111;114;112;115;114;114;116;114 04:35:22 INFO - PROCESS | 1649 | |1;audio-beat-detection;146;108;110;143;120;110;109;106;127;109 04:35:22 INFO - PROCESS | 1649 | |2;audio-dft;186;185;185;185;185;188;186;181;185;185 04:35:22 INFO - PROCESS | 1649 | |3;audio-fft;86;60;61;91;61;60;59;61;75;59 04:35:22 INFO - PROCESS | 1649 | |4;audio-oscillator;91;68;85;70;69;70;83;69;68;83 04:35:22 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;88;91;91;90;91;91;91;91;91;90 04:35:22 INFO - PROCESS | 1649 | |6;imaging-darkroom;97;97;98;97;96;97;97;97;121;111 04:35:22 INFO - PROCESS | 1649 | |7;imaging-desaturate;85;83;85;84;84;85;95;129;102;84 04:35:22 INFO - PROCESS | 1649 | |8;json-parse-financial;62;61;63;62;63;64;65;64;65;65 04:35:22 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;54;58;67;66;60;58;58;57;59;58 04:35:22 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;83;92;98;99;76;81;83;82;81;81 04:35:22 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;134;132;132;134;133;132;136;137;181;143 04:35:22 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;161;161;161;158;166;163;164;162;159;205 04:35:22 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;64;64;62;62;64;61;63;63;63;63 04:35:22 INFO - PROCESS | 1649 | __end_tp_report 04:35:22 INFO - PROCESS | 1649 | __start_cc_report 04:35:22 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2088 04:35:22 INFO - PROCESS | 1649 | __end_cc_report 04:35:22 INFO - PROCESS | 1649 | __startTimestamp1493811322774__endTimestamp 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | ------- Summary: start ------- 04:35:22 INFO - PROCESS | 1649 | Number of tests: 14 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.11 (2.7%) stddev-sans-first:1.48 04:35:22 INFO - PROCESS | 1649 | Values: 105.0 114.0 111.0 114.0 112.0 115.0 114.0 114.0 116.0 114.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:115.00 stddev:14.99 (13.0%) stddev-sans-first:12.25 04:35:22 INFO - PROCESS | 1649 | Values: 146.0 108.0 110.0 143.0 120.0 110.0 109.0 106.0 127.0 109.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:185.10 Median:185.00 stddev:1.73 (0.9%) stddev-sans-first:1.80 04:35:22 INFO - PROCESS | 1649 | Values: 186.0 185.0 185.0 185.0 185.0 188.0 186.0 181.0 185.0 185.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:67.30 Median:61.00 stddev:12.18 (20.0%) stddev-sans-first:10.87 04:35:22 INFO - PROCESS | 1649 | Values: 86.0 60.0 61.0 91.0 61.0 60.0 59.0 61.0 75.0 59.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.50 stddev:8.82 (11.5%) stddev-sans-first:7.39 04:35:22 INFO - PROCESS | 1649 | Values: 91.0 68.0 85.0 70.0 69.0 70.0 83.0 69.0 68.0 83.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:91.00 stddev:0.97 (1.1%) stddev-sans-first:0.44 04:35:22 INFO - PROCESS | 1649 | Values: 88.0 91.0 91.0 90.0 91.0 91.0 91.0 91.0 91.0 90.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:100.80 Median:97.00 stddev:8.36 (8.6%) stddev-sans-first:8.76 04:35:22 INFO - PROCESS | 1649 | Values: 97.0 97.0 98.0 97.0 96.0 97.0 97.0 97.0 121.0 111.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:91.60 Median:84.50 stddev:14.52 (17.2%) stddev-sans-first:15.20 04:35:22 INFO - PROCESS | 1649 | Values: 85.0 83.0 85.0 84.0 84.0 85.0 95.0 129.0 102.0 84.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:64.00 stddev:1.43 (2.2%) stddev-sans-first:1.42 04:35:22 INFO - PROCESS | 1649 | Values: 62.0 61.0 63.0 62.0 63.0 64.0 65.0 64.0 65.0 65.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:58.50 stddev:4.01 (6.8%) stddev-sans-first:3.72 04:35:22 INFO - PROCESS | 1649 | Values: 54.0 58.0 67.0 66.0 60.0 58.0 58.0 57.0 59.0 58.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:83.00 stddev:7.86 (9.5%) stddev-sans-first:8.28 04:35:22 INFO - PROCESS | 1649 | Values: 83.0 92.0 98.0 99.0 76.0 81.0 83.0 82.0 81.0 81.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:135.00 stddev:15.00 (11.1%) stddev-sans-first:15.78 04:35:22 INFO - PROCESS | 1649 | Values: 134.0 132.0 132.0 134.0 133.0 132.0 136.0 137.0 181.0 143.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:162.50 stddev:13.90 (8.6%) stddev-sans-first:14.62 04:35:22 INFO - PROCESS | 1649 | Values: 161.0 161.0 161.0 158.0 166.0 163.0 164.0 162.0 159.0 205.0 04:35:22 INFO - PROCESS | 1649 | 04:35:22 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:0.97 04:35:22 INFO - PROCESS | 1649 | Values: 64.0 64.0 62.0 62.0 64.0 61.0 63.0 63.0 63.0 63.0 04:35:22 INFO - PROCESS | 1649 | -------- Summary: end -------- 04:35:22 INFO - PROCESS | 1649 | 04:35:23 INFO - TEST-INFO | 1649: exit 0 04:35:23 INFO - TEST-OK | kraken | took 59499ms 04:35:23 INFO - SUITE-END | took 1178s 04:35:23 INFO - Completed test suite (00:19:38) 04:35:23 INFO - javascript benchmark 04:35:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7764.845094579238, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.155707180525, 3524.859005639773, 3539.893803185905, 3559.3415218184623, 3559.661832125947, 4355.04189078403, 5807.332156801969, 5989.251343582052, 6027.638341699501, 6171.47542458891, 6081.0, 6131.0, 6156.322804491502, 6163.137160797481, 6175.228096487939, 4463.794775410637, 5370.3287089113865, 5430.0768869292115, 5508.724563771795, 5525.972370138144, 5278.551323137538, 5291.153415453528, 5342.439043900393, 5359.892802143955, 5567.248421463091, 5379.892402151954, 5384.111621582434, 5385.542228910547, 5390.407055223922, 5396.676199428047, 5369.033573956666, 5379.354477462691, 5386.730663466811, 5391.703456309901, 5397.865053373677, 5208.947910520922, 5325.680459172462, 5329.706866122362, 5331.706756128411, 5362.758675859595, 5996.97001514994, 6003.939960600425, 6007.189029481052, 6009.128676341906, 6015.699215039274, 6299.748010079591, 6321.0, 6335.3981371769605, 6336.46140078094, 6336.904946425761, 6479.384458476437, 6489.610623362613, 6494.772682956121, 6499.447546958514, 6500.414962653384, 6133.938660613381, 6165.383461653843, 6169.0, 6185.752569897199, 6204.441600255998, 6347.619142851444, 6354.364563543609, 6625.370589793962, 6639.800805975732, 6700.731970721165, 6275.246970363494, 6349.079383489368, 6366.745330186741, 6366.77716279928, 6399.776007839796, 6505.251896031922, 6515.0, 6523.608583485006, 6534.509911756637, 6537.738490460329, 6270.905936410957, 6421.775237866652, 6421.940379837368, 6423.518236132215, 6436.903446448307, 6253.062040693932, 6312.147860038928, 6355.968220158869, 6356.4279214870885, 6391.424771770563, 5240.737963101829, 5242.9213561796605, 5245.973770131125, 5248.868778280574, 5273.604479664041, 4455.532169122195, 4644.744539050317, 4647.604953578916, 4653.95346046542, 4684.063187362541, 5998.190244317048, 6009.789657361971, 6062.545309101835, 6193.225846769154, 6245.594036387621, 6290.433860952537, 6291.465225455796, 6308.905366419507, 6336.112944187817, 6343.524235682342, 5248.921266181011, 6213.912565301054, 6239.0, 6247.968760156261, 6286.339934306923, 5641.097424412074, 5680.8863822723315, 5684.687342196219, 5684.772609095672, 5698.31620205578, 6409.743610255724, 6411.5832470889245, 6748.426383757239, 6774.627395493295, 6774.966125169342, 6352.269489008823, 6380.170577824853, 6465.547411681137, 6478.902816457663, 6492.642904640101, 6614.4708423325055, 6660.83347916306, 6666.633335166613, 6673.432758215606, 6722.428593569406, 6402.327755585597, 6407.935920640734, 6408.519361047846, 6447.194100737408, 6450.161479007699, 6282.120503129657, 6350.142730731292, 6412.839679007876, 6436.259830119596, 6552.803415897531, 5239.528442440199, 6374.394432529088, 6408.198975128109, 6408.775692850728, 6413.35866413355, 6311.810645680637, 6314.242290925118, 6318.968405157945, 6374.298827129105, 6406.135171751754, 6118.43644382056, 6123.526657168115, 6301.338359472189, 6367.3314301997625, 6372.904406433814, 6334.556581039283, 6378.553501254868, 6387.105805187184, 6397.808065758035, 6402.263739669997, 6096.055111457731, 6116.8836339025665, 6359.04614307839, 6360.141380913703, 6374.713137908712], "value": 5927.789727076341, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.9036515618126, 831.0359982420391, 886.9512176830276, 888.307120446052, 920.9401388909724, 40235.59764402355, 40858.59141408585, 40860.59139408605, 40881.0, 40923.59076409231, 38241.617583824154, 38470.0, 38502.61497385025, 38514.0, 38538.0, 7877.2122787721055, 7957.965464489623, 8014.5591992440395, 8094.190580941918, 11596.826047609293, 11710.355930423822, 11836.704082397922, 11846.052315814713, 11866.94066529666, 11899.821502677467, 9867.60529578816, 11857.22928009681, 11860.0, 11879.881201187964, 11879.881201188007, 11793.587224447147, 11812.350320732356, 11821.468033938494, 11831.881681183164, 11836.585719499863, 11448.313101213955, 11535.653930382103, 11549.307041577533, 11554.480048397758, 11562.30626162433, 39837.601623983675, 40201.79899100515, 40218.798906005286, 40270.0, 40337.19325613471, 3978.8209530571194, 4083.2241874044134, 4090.6727461802984, 4114.753114813091, 4117.629413352783, 28603.14190574286, 29858.40283194346, 30618.081457556087, 30782.846085769652, 30842.0, 3123.7813353065294, 3169.7464202863716, 3197.488401855692, 3203.0550987458755, 3255.166399944506, 366889.0, 367486.3251367479, 367874.0, 367887.32112679066, 368829.0, 53328.933421332134, 53424.198637020476, 53460.73269633627, 53505.464945350046, 53585.46414535883, 55149.0, 55221.72389138109, 55274.0, 55326.51030703628, 55349.61625959303, 15265.0, 15354.462593809163, 15367.846321536865, 15402.614934626725, 15411.767058635282, 13137.211767293993, 13140.934295328461, 13152.934235328763, 13159.53941612039, 13171.93414032943, 10895.182861285435, 11954.760904781855, 11972.521099155936, 12041.157119001586, 12054.095942804324, 5297.735113244323, 5339.305890234323, 5348.224507446398, 5349.090654588651, 5362.624616276823, 752.450710980987, 971.6647756523988, 976.1361195342173, 981.617169303972, 1002.3134153105146, 24105.638415423782, 25673.10144144946, 28346.574801377996, 29020.854895725388, 29067.56398654022, 720.6108701301343, 1094.5621751299384, 1097.7475180708323, 1180.2505409065134, 1212.3453335198894, 12760.744785104245, 13459.93270033663, 13506.392212350467, 13530.729385412433, 14814.62963425923, 499610.0, 501403.0, 501974.0, 502729.0, 503925.0, 49214.261786073235, 49255.261171082464, 49333.753331233114, 49435.0112997738, 49447.76380590442, 1438.359929831236, 1448.862358075981, 1474.2333986327264, 1491.6569189086354, 1492.7611582147022, 27228.40293036653, 27269.0, 28043.43913121767, 28159.15522534327, 28282.2929426766, 40190.0, 40616.78149655515, 40649.79675101724, 40667.7966610165, 40707.59292407038, 480588.0, 481830.5908470575, 482263.0, 483922.0, 484051.0, 29299.853500733214, 29420.55869162007, 29428.705712943454, 29653.110406687832, 29867.0, 40269.0, 40314.39528407135, 40630.39054414127, 40832.3875141879, 41375.7931210342, 27109.78005989696, 28064.85967570149, 28429.573556397085, 28564.0002599908, 29983.550246746752, 28499.0, 28839.56740648934, 28896.42207155803, 29844.85077574598, 29873.95441159549, 33316.833910813, 34394.82802585971, 34506.65493345034, 34664.13339666528, 35159.64840351564, 28688.13935581936, 28733.706983185388, 28902.42195156043, 29259.41481170407, 29763.553546696385, 19543.120559575138, 21912.937825536712, 22165.445863853533, 23012.654810178195, 23093.53812923766], "value": 18815.032486755346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.4226509681736, 431.7888323253275, 435.5535576034564, 439.3958307327424, 441.8608138436392, 21348.146074157034, 21736.456588585275, 22344.0, 22546.0, 22925.77074229257, 18992.525186870334, 23071.0, 23669.0, 24376.87811560944, 24639.384015399624, 5453.918191227135, 5880.294364676245, 7057.188423331306, 7099.325564071431, 7121.611285799271, 6118.847028824271, 6949.861002779941, 7009.684564194624, 7112.964435177817, 7124.786256412316, 6687.465002799764, 6962.443004559623, 7023.122109736283, 7029.578225306498, 7128.821779455503, 6726.697298621574, 6931.965340173318, 6968.0, 7055.15338159419, 7063.752768653072, 6875.07186529817, 6878.8624227515165, 6880.174379074493, 6881.965590172067, 6882.070920425778, 23352.766472335228, 28098.157055288375, 28350.432991340058, 28551.714482855114, 29090.12729618115, 2747.2719729271757, 2776.9028084016963, 2886.985565072161, 3080.676528964449, 3134.8275844828527, 16408.933419327706, 16455.424060157955, 16594.08732519711, 16712.83287167125, 16789.83210167895, 2118.788121187869, 2132.4668832791804, 2133.777539810036, 2160.7299087614047, 2213.1147540983575, 166292.16853915653, 168882.0, 170166.0, 171072.0, 173963.0, 17002.829971700125, 19494.512637184183, 19584.21663133487, 20530.38408847737, 20596.0, 32342.514862277083, 32556.511652325233, 32602.83698581492, 32615.347693046006, 32618.673813262038, 9331.860022099674, 9544.759181306386, 10257.435841028666, 10577.471126443646, 10667.306625069346, 9057.77355566116, 9070.503366944513, 9070.591823367964, 9269.397489163182, 9284.907150928404, 9415.387999780129, 9526.0, 9615.375000624937, 9617.326787124834, 9634.90365096354, 3727.2172843702583, 3776.4524143998965, 3783.4246636928387, 3793.3551296279697, 3796.734228603971, 1032.3496197395593, 1053.6206965492418, 1054.4306074719718, 1101.658485869383, 1106.750981029262, 20447.0, 21921.232756853435, 21925.780742192692, 22021.22925697593, 22099.67401955888, 1016.7102375822855, 1022.5756311130946, 1041.5469270867197, 1049.7480604654827, 1052.2949623752104, 10835.349879007284, 11373.715657108638, 11379.829302560469, 11392.715182120348, 11408.771824563462, 785870.0, 793308.0, 798635.0, 803490.0, 824495.0, 115826.0, 147144.0, 154070.0, 154448.22775886275, 154635.0, 1206.4028305988593, 1219.481720268882, 1247.7504499100035, 1250.3685638752372, 1254.6298841841678, 18275.54311142179, 19038.0, 19072.237110515423, 19101.617967640846, 19177.80822191816, 47395.0, 62173.37826621857, 62750.37249627628, 63118.36881631309, 64296.67851660899, 86189.1381086181, 86677.0, 88421.55789221013, 89329.55335223282, 90089.54955225182, 7672.846543069219, 9599.520023998632, 11398.544058237578, 11654.475548600163, 11942.641720748392, 11113.944430277797, 13059.738805223653, 13230.007749418639, 13416.932915335361, 13601.727965440437, 10931.0, 11344.943275283571, 11503.942480287546, 11585.304881706787, 11806.645800625995, 9835.967223441436, 10595.735106622396, 10604.098651614391, 10638.308509946828, 10958.452077396258, 9843.360181588174, 10771.892281077402, 11723.648290551297, 11878.940605296919, 11935.283882967049, 11697.356645384585, 11837.46731397072, 12058.75882482363, 12072.577459788865, 12076.939615302219, 9666.709998700051, 9930.25523085757, 9955.800883982134, 9962.203023757937, 9996.200303975518], "value": 11701.312293213634, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.5547302599687, 1615.741481362982, 1627.2351994562553, 1639.1558347451062, 1642.334854383975, 9500.0, 9910.008999100086, 11229.213955023151, 11480.885191148085, 11791.764164716722, 11300.604478843243, 11397.487113079911, 11399.544018239261, 11421.657350279484, 11422.485988130533, 2480.057578120316, 2542.707588627313, 2547.2103647869126, 2550.1584477122506, 2551.260134560984, 2138.8823614701187, 2208.8232941364654, 2211.8009379155874, 2220.145244081032, 2221.9888900555475, 2116.7459904811444, 2165.4369863835436, 2424.6363045543135, 2513.0450428837016, 2529.53203657324, 2494.650748895156, 2516.584763514027, 2518.5718427867305, 2521.420073383132, 2528.190978886757, 2493.7506249375097, 2496.700395952479, 2497.7377375375686, 2500.274920273119, 2500.362407586072, 11327.716807079807, 11460.426978651034, 11476.655700329004, 11511.769764604662, 11622.128340374506, 6026.427489388501, 6193.907091393633, 6203.8138855834395, 6209.2548894133, 6217.409346112112, 3542.4863394807608, 3672.137047793766, 3832.9233415331814, 3857.517810273716, 3904.472896159039, 1181.5805389086922, 1198.1493139870702, 1216.9817452738216, 1255.2593969558004, 1261.4197469164196, 15194.620134496616, 16171.029738215744, 16202.83797162025, 16207.270672819752, 16215.432459863967, 4426.849019255017, 4851.288700298593, 5060.139776238048, 5102.591792656579, 5184.5593124584075, 13277.402516886763, 13309.0, 13313.46746130144, 13314.400851961685, 13347.799783003262, 6177.69111544421, 6283.685815709287, 6284.371562843679, 6296.150019747367, 6312.116303717483, 5387.784488620489, 5491.615586908878, 5553.305836770403, 5569.972150139304, 5664.830055098354, 3807.5430948286385, 4123.4021066945725, 4220.599043090963, 4241.91516169681, 4283.657307415399, 960.2222200018008, 1075.4031512510633, 1156.1329003247565, 1186.8753780853058, 1193.5345215366015, 978.8042391521724, 979.9687244024099, 987.0, 988.5057471264367, 1009.8081364540714, 5859.20900678403, 6743.123393958754, 6875.518713689994, 7059.89410158848, 7084.681189346492, 837.8198687282263, 1068.513826209073, 1083.978320433587, 1090.7164137324194, 1092.808758467265, 3813.542374915028, 3834.6740527055513, 4356.041670832412, 4408.6913916026215, 4431.645468362523, 13795.724085518234, 14315.355808988621, 14363.56909292702, 14373.353199106064, 14374.85625143756, 13996.300184990914, 14237.85762142386, 14256.501022464372, 14285.928570357082, 14304.427822887175, 10601.522931468102, 10784.460776961121, 10790.406527641055, 10812.0, 10817.729556761144, 6831.795046148623, 6888.586684798928, 6945.236024037251, 6957.756478523227, 6979.255186203449, 12343.75312493763, 12612.306323151948, 12820.871791282341, 12821.807672885101, 12966.870331296566, 12898.80651790205, 13026.804597931228, 13060.869391305965, 13124.671883202996, 13358.866411335763, 9340.71977840666, 9419.670311539063, 9486.478243696663, 9519.714408567754, 9556.85664715016, 10345.793084138124, 10504.894951050697, 10577.735556610838, 10602.946985265333, 10628.36229826213, 7087.184973728087, 8710.782230444289, 9075.773105672411, 9087.59105840252, 9109.089091091102, 8366.498010119412, 8560.0, 8636.00685921102, 8688.174623410765, 8856.734297971072, 7935.722249721232, 8008.359331253602, 8048.557329346942, 8154.592270386575, 8161.836763264582, 5897.174395584536, 5995.5803093783015, 6158.291796443287, 6244.0, 6263.843403914939, 5973.253343332083, 6032.788852390146, 6148.78479253224, 6181.81454556364, 6280.937190628035], "value": 5326.146277473262, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.8280785395521, 388.1189699382402, 388.4891367851277, 395.8693631101735, 396.60537764923896, 4179.895502612436, 4646.279826626878, 4797.256425254087, 4980.825671101512, 5018.723970181643, 4481.641468682497, 4590.563896429834, 4923.458419573844, 4987.0, 5000.874978125548, 3276.0, 3849.461075449425, 3931.842726290945, 4179.707420480568, 4195.077083041741, 3374.2285300217336, 3595.5347871235836, 4167.979160104211, 4198.076423186894, 4224.239636865363, 3499.982500087496, 3652.7990960497164, 3860.7104467164936, 4192.496900371944, 4265.488141423034, 3816.637419445148, 4006.0, 4086.420862411515, 4188.371744238359, 4219.578042195772, 3284.3232765296207, 3851.4030325299623, 3860.3244432224246, 3877.9030524236837, 3917.8824635260703, 4448.933266001012, 4498.280275155959, 4514.8419805306985, 4868.440129385131, 4916.4188800879465, 4880.389951256093, 4882.438519570223, 4912.606991440676, 4928.6303527235605, 4942.676941837331, 4940.55535001848, 5028.296038554606, 5340.928965844655, 5386.515213630752, 5392.274472168908, 3814.7030009796526, 4193.308104162809, 4332.371806088131, 4338.652907767371, 4371.803268852909, 4552.180607490651, 4995.000999800018, 5027.622928280357, 5111.795528178868, 5544.0, 3781.470594116826, 4199.601037901394, 4267.829286828554, 4378.8762450211625, 4407.920059585422, 3947.4078888167005, 4016.136530645925, 4176.227397931331, 4361.956380436155, 4461.739039217539, 4406.361077643788, 4740.502247263988, 4749.4775574686755, 4862.41651001882, 4938.913439043405, 4781.306710526954, 5118.59051275897, 5347.278117454094, 5390.67655940637, 5413.891722165614, 1281.35932033983, 1509.8943073984935, 1522.6421790879135, 1524.764940398281, 1538.361579944333, 1022.8721409823772, 1072.9624463143753, 1099.2689861242184, 1153.7501871350732, 1169.450478116499, 4608.746518941423, 4737.763111844394, 4766.71197825046, 4773.474917759044, 5147.455763271004, 4654.208129869957, 4824.333506535058, 5208.84373468789, 5372.179605707035, 5534.252875861707, 4337.392765012901, 4668.5564871337165, 4908.9754551227015, 5151.871203219875, 5210.296609957683, 2316.5945959457026, 2597.9350516237246, 2702.513547561458, 2835.560488124344, 2851.0734011445948, 5732.942670573241, 5747.568932330092, 5758.942410575841, 5767.183337248754, 5779.450952159538, 4532.841350552781, 5332.173513105475, 5575.749091290821, 5681.375048744635, 5687.241687781423, 4683.414573178353, 4757.9532502849315, 4970.751462426864, 5429.995450841607, 5496.31296087989, 4868.853934381974, 4955.554000140005, 5132.461091585479, 5228.738563071755, 5353.678779273256, 4818.445878723992, 5049.601439316295, 5431.306711436261, 5446.509814116748, 5476.835694929158, 5023.748812559431, 5662.348829884616, 5730.914036289542, 5742.397048309867, 5749.051406518045, 3649.489071529935, 3979.6668116181404, 4082.9785958389984, 4434.782608695652, 4531.660125490667, 4978.8755281118265, 5114.872128196825, 5151.433342332415, 5500.477454641803, 5692.772289108555, 4618.953810461987, 4847.151748443937, 5399.676019438846, 5429.511343979061, 5491.512889315234, 4624.5375462453485, 4721.598664113451, 5347.385050719217, 5446.373667028342, 5461.781528738806, 4377.1683380157665, 4940.863601371633, 5070.442251352422, 5308.840734777963, 5317.494837990384, 5061.936993231463, 5101.724568857786, 5396.676199428047, 5408.864778380572, 5438.918416223839, 5077.8730531737, 5292.655977361459, 5302.681839089667, 5343.492368225013, 5343.9465605345], "value": 4064.4112158080916, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.6328207383569, 817.7056259746487, 832.196929962586, 893.584483215305, 905.3164860530301, 16311.673766524662, 17250.82749172508, 17255.741163882536, 17271.654566908655, 17275.74086388705, 15750.763738543903, 15955.202239888018, 15984.040957542555, 15993.360265589363, 16012.919935400336, 778.4900889917113, 959.8704174936399, 961.0965692249264, 961.4471678784691, 978.2711879649671, 983.2772911909741, 987.521052289639, 992.0278127435118, 993.3642468819961, 1019.6125472320508, 1057.8994995475418, 1058.3279617442902, 1058.6559368205326, 1059.1685526861415, 1061.0079575596842, 1055.4247934875511, 1055.4617145255897, 1055.5566662001977, 1056.287006270764, 1057.228223396917, 785.2187073861487, 785.654312102673, 785.8231897823001, 786.0371045469254, 787.2127872127872, 16048.83951160485, 16285.02289862612, 16311.265993030342, 17413.955162690152, 17434.215460304316, 14561.053531520418, 14775.778363324558, 14831.851681483155, 14845.257737113208, 14861.479848205368, 12117.091218158674, 12198.756024879542, 12216.572419965258, 12278.140530162893, 12538.561150359785, 3764.698824094066, 3852.7880966546827, 3863.4011728182177, 3892.4939757831585, 4021.7586944783407, 119947.0, 122091.55816883613, 122129.0, 122277.77722222752, 125618.0, 11174.832377514344, 11509.827352589718, 11665.76668466626, 11733.35466549348, 11924.284542927453, 24215.0, 24511.632325515133, 25113.0, 25144.371390715012, 25146.74853251444, 8126.553039582762, 8144.75565733029, 8189.590520473953, 8229.876551851727, 8331.208535189147, 3989.2819292527042, 4455.22033644111, 4549.566886430764, 4724.126036683225, 4802.711837289774, 3556.075420390717, 3674.65090816372, 3676.0809797550614, 3680.8895733128047, 3682.3924052531033, 648.3937518420292, 682.4199430484049, 685.5509641185032, 686.4371215603157, 688.5765254368628, 587.8383444552783, 666.3436515032689, 667.8096742428385, 696.4637229333385, 700.3801635552572, 8821.558922053871, 9976.351537150062, 9986.400815951067, 10048.397096174253, 10168.33905796121, 661.9304972977865, 667.8864593019198, 683.5767205257374, 706.780897921646, 722.8590424867206, 4360.41134446852, 4872.731999739977, 4901.803927842918, 4932.605391568738, 4946.802127914843, 97330.51334743423, 107035.0, 107248.0, 108024.0, 109739.45130274458, 90071.54964225137, 92524.53737731268, 93188.0, 93294.13411731727, 94283.0, 82959.17040829636, 84715.57642211749, 85018.57490712508, 85115.5744221275, 85193.14806851852, 9680.419174849532, 9688.75778105553, 9689.660861869801, 9721.805563888824, 9767.609295628095, 51174.74412627913, 53537.73231133819, 54526.72736636292, 56188.719056406095, 56697.73209071591, 63685.6815715937, 68467.97298040433, 70242.64878675574, 70551.29448705447, 70678.0, 11644.301341919512, 11744.647660570197, 12018.098642601664, 12363.0, 12463.937680311541, 12307.69230769238, 12690.492380304684, 12712.792284732936, 12864.0, 13126.60620181396, 11590.42047897585, 11622.6513204604, 12172.2696638202, 12391.318477483464, 12431.782259908332, 11672.299662020307, 11999.700007499883, 12005.279683219034, 12167.817482737943, 12419.659829170148, 11340.149488788209, 11766.411679416165, 11870.525178992744, 12021.519139234682, 12113.81829272544, 8785.736427907173, 8856.3800533962, 8983.236424903957, 9172.6789562365, 9291.86062209081, 8764.21122099014, 9926.928980532677, 9939.462618912805, 9943.648333657813, 9953.353032052893], "value": 7757.315767845296, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1419.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 111.0, 114.0, 112.0, 115.0, 114.0, 114.0, 116.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 108.0, 110.0, 143.0, 120.0, 110.0, 109.0, 106.0, 127.0, 109.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 185.0, 185.0, 185.0, 188.0, 186.0, 181.0, 185.0, 185.0], "value": 185.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 60.0, 61.0, 91.0, 61.0, 60.0, 59.0, 61.0, 75.0, 59.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 68.0, 85.0, 70.0, 69.0, 70.0, 83.0, 69.0, 68.0, 83.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 91.0, 90.0, 91.0, 91.0, 91.0, 91.0, 91.0, 90.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 98.0, 97.0, 96.0, 97.0, 97.0, 97.0, 121.0, 111.0], "value": 100.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 85.0, 84.0, 84.0, 85.0, 95.0, 129.0, 102.0, 84.0], "value": 91.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 63.0, 62.0, 63.0, 64.0, 65.0, 64.0, 65.0, 65.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 67.0, 66.0, 60.0, 58.0, 58.0, 57.0, 59.0, 58.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 92.0, 98.0, 99.0, 76.0, 81.0, 83.0, 82.0, 81.0, 81.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 132.0, 134.0, 133.0, 132.0, 136.0, 137.0, 181.0, 143.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 158.0, 166.0, 163.0, 164.0, 162.0, 159.0, 205.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 62.0, 64.0, 61.0, 63.0, 63.0, 63.0, 63.0], "value": 62.9, "unit": "score"}]}]} 04:35:24 INFO - Return code: 0 04:35:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:35:24 INFO - # TBPL SUCCESS # 04:35:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:35:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:35:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:35:24 INFO - 2017-05-03 04:35:24.119 screenresolution[1653:9762] starting screenresolution argv=screenresolution get 04:35:24 INFO - 2017-05-03 04:35:24.122 screenresolution[1653:9762] Display 0: 1600x1200x32@60 04:35:24 INFO - 2017-05-03 04:35:24.128 screenresolution[1654:9765] starting screenresolution argv=screenresolution list 04:35:24 INFO - Available Modes on Display 0 04:35:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:35:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:35:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:35:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:35:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:35:24 INFO - Intel Iris: 04:35:24 INFO - Chipset Model: Intel Iris 04:35:24 INFO - Type: GPU 04:35:24 INFO - Bus: Built-In 04:35:24 INFO - VRAM (Dynamic, Max): 1536 MB 04:35:24 INFO - Vendor: Intel (0x8086) 04:35:24 INFO - Device ID: 0x0a2e 04:35:24 INFO - Revision ID: 0x0009 04:35:24 INFO - Displays: 04:35:24 INFO - Display: 04:35:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:35:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:35:24 INFO - Display Serial Number: 1600x1200 60 04:35:24 INFO - Main Display: Yes 04:35:24 INFO - Mirror: Off 04:35:24 INFO - Online: Yes 04:35:24 INFO - Rotation: Supported 04:35:24 INFO - Return code: 0 04:35:24 INFO - Running post-action listener: _resource_record_post_action 04:35:24 INFO - [mozharness: 2017-05-03 11:35:24.364775Z] Finished run-tests step (success) 04:35:24 INFO - Running post-run listener: _resource_record_post_run 04:35:24 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 40719360; Write bytes: 424767488; Read time: 398; Write time: 1479 04:35:24 INFO - TinderboxPrint: CPU usage
53.7% 04:35:24 INFO - TinderboxPrint: I/O read bytes / time
40,719,360 / 398 04:35:24 INFO - TinderboxPrint: I/O write bytes / time
424,767,488 / 1,479 04:35:24 INFO - TinderboxPrint: CPU idle
2,213.6 (46.3%) 04:35:24 INFO - TinderboxPrint: CPU system
955.2 (20.0%) 04:35:24 INFO - TinderboxPrint: CPU user
1,608.8 (33.7%) 04:35:24 INFO - TinderboxPrint: Swap in / out
161,402,880 / 0 04:35:24 INFO - install - Wall time: 16s; CPU: 54.0%; Read bytes: 117469696; Write bytes: 112926720; Read time: 10870; Write time: 204 04:35:24 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 38765568; Write bytes: 297547776; Read time: 378; Write time: 1177 04:35:24 INFO - Running post-run listener: _upload_blobber_files 04:35:24 INFO - Blob upload gear active. 04:35:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:35:24 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:35:24 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:35:24 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:35:25 INFO - (blobuploader) - INFO - Open directory for files ... 04:35:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:35:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:35:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:26 INFO - (blobuploader) - INFO - Done attempting. 04:35:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:35:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:35:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:27 INFO - (blobuploader) - INFO - Done attempting. 04:35:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:35:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:35:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:28 INFO - (blobuploader) - INFO - Done attempting. 04:35:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:35:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:35:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:30 INFO - (blobuploader) - INFO - Done attempting. 04:35:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:35:30 INFO - Return code: 0 04:35:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:35:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:35:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7996b084ba481c01efce233bbcc697d1c0ce5756bf4d6ddb2769d9e3a7562b458cbac6c9b1d391b596d209b7e4c335643b1ad285d18caecfda25ac2b0340fcbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fa2c4eb9cd2031b845f31b2c0e52e1c9b0a42cc2917c9956bbc30cc2c49d5356edecd74bec0c7e3a5719f753be70454875f666e1e396e4b55df75c9f2b67f8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e34aad079852decfac66cf7035a2ccc055629689eb39ecfc340b032b69914fb4923700e8eeb28fa7556589ef2d23b8601a000f99397dcce20fb5954c55834a0e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb53414639a3fc82c0e50b050f68561b4f548b1654d9fb82f0a741504403dc6c6f13dd34898bf9bdffee895a1fdb38dd7ae219d01106f7641868d6567626f2c5"} 04:35:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:35:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:35:30 INFO - Contents: 04:35:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7996b084ba481c01efce233bbcc697d1c0ce5756bf4d6ddb2769d9e3a7562b458cbac6c9b1d391b596d209b7e4c335643b1ad285d18caecfda25ac2b0340fcbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fa2c4eb9cd2031b845f31b2c0e52e1c9b0a42cc2917c9956bbc30cc2c49d5356edecd74bec0c7e3a5719f753be70454875f666e1e396e4b55df75c9f2b67f8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e34aad079852decfac66cf7035a2ccc055629689eb39ecfc340b032b69914fb4923700e8eeb28fa7556589ef2d23b8601a000f99397dcce20fb5954c55834a0e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb53414639a3fc82c0e50b050f68561b4f548b1654d9fb82f0a741504403dc6c6f13dd34898bf9bdffee895a1fdb38dd7ae219d01106f7641868d6567626f2c5"} 04:35:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:35:30 INFO - Copying logs to upload dir... 04:35:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:35:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.503190 ========= master_lag: 2.53 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-05-03 04:35:33.015240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 04:35:33.019208) ========= 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.8GVdzmHmtq/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.E606IiTPXU/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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-Beta/sha512/7996b084ba481c01efce233bbcc697d1c0ce5756bf4d6ddb2769d9e3a7562b458cbac6c9b1d391b596d209b7e4c335643b1ad285d18caecfda25ac2b0340fcbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fa2c4eb9cd2031b845f31b2c0e52e1c9b0a42cc2917c9956bbc30cc2c49d5356edecd74bec0c7e3a5719f753be70454875f666e1e396e4b55df75c9f2b67f8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e34aad079852decfac66cf7035a2ccc055629689eb39ecfc340b032b69914fb4923700e8eeb28fa7556589ef2d23b8601a000f99397dcce20fb5954c55834a0e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb53414639a3fc82c0e50b050f68561b4f548b1654d9fb82f0a741504403dc6c6f13dd34898bf9bdffee895a1fdb38dd7ae219d01106f7641868d6567626f2c5"} build_url:https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011108 build_url: 'https://queue.taskcluster.net/v1/task/TbwiJQjGTvqnmAIfxZ_NTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7996b084ba481c01efce233bbcc697d1c0ce5756bf4d6ddb2769d9e3a7562b458cbac6c9b1d391b596d209b7e4c335643b1ad285d18caecfda25ac2b0340fcbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fa2c4eb9cd2031b845f31b2c0e52e1c9b0a42cc2917c9956bbc30cc2c49d5356edecd74bec0c7e3a5719f753be70454875f666e1e396e4b55df75c9f2b67f8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e34aad079852decfac66cf7035a2ccc055629689eb39ecfc340b032b69914fb4923700e8eeb28fa7556589ef2d23b8601a000f99397dcce20fb5954c55834a0e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb53414639a3fc82c0e50b050f68561b4f548b1654d9fb82f0a741504403dc6c6f13dd34898bf9bdffee895a1fdb38dd7ae219d01106f7641868d6567626f2c5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 04:35:33.055608) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 04:35:33.056004) ========= 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.8GVdzmHmtq/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.E606IiTPXU/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005313 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 04:35:33.104488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 04:35:33.104781) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 04:35:33.105096) ========= ========= Total master_lag: 2.67 =========