builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0217 starttime: 1476918307.69 results: success (0) buildid: 20161019135423 builduid: 7c89bf5e3dbf4249a8a4b0a732a71799 revision: 1bb0c02b6c1ce9ed61e2e08b8f37eef5899a7e31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:07.690540) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:07.690977) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:07.691250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:07.720359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:07.720626) ========= 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.GAvRJvkgAo/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.94LhLQVA28/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 --2016-10-19 16:05:07-- 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% 59.0M=0s 2016-10-19 16:05:07 (59.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160641 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:07.906151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:07.906461) ========= 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.GAvRJvkgAo/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.94LhLQVA28/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.025404 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:07.954524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 16:05:07.954866) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1bb0c02b6c1ce9ed61e2e08b8f37eef5899a7e31 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1bb0c02b6c1ce9ed61e2e08b8f37eef5899a7e31 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GAvRJvkgAo/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.94LhLQVA28/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 2016-10-19 16:05:08,041 truncating revision to first 12 chars 2016-10-19 16:05:08,041 Setting DEBUG logging. 2016-10-19 16:05:08,041 attempt 1/10 2016-10-19 16:05:08,041 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1bb0c02b6c1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 16:05:09,064 unpacking tar archive at: mozilla-aurora-1bb0c02b6c1c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.308802 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 16:05:09.291170) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:09.291492) ========= script_repo_revision: 1bb0c02b6c1ce9ed61e2e08b8f37eef5899a7e31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:09.291878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:09.292178) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 16:05:09.373719) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-19 16:05:09.374137) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GAvRJvkgAo/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.94LhLQVA28/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:05:09 INFO - MultiFileLogger online at 20161019 16:05:09 in /builds/slave/test 16:05:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:05:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:05:09 INFO - {'append_to_log': False, 16:05:09 INFO - 'base_work_dir': '/builds/slave/test', 16:05:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:05:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:05:09 INFO - 'branch': 'Mozilla-Aurora', 16:05:09 INFO - 'buildbot_json_path': 'buildprops.json', 16:05:09 INFO - 'config_files': ('talos/mac_config.py',), 16:05:09 INFO - 'default_actions': ('clobber', 16:05:09 INFO - 'read-buildbot-config', 16:05:09 INFO - 'download-and-extract', 16:05:09 INFO - 'populate-webroot', 16:05:09 INFO - 'create-virtualenv', 16:05:09 INFO - 'install', 16:05:09 INFO - 'run-tests'), 16:05:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:05:09 INFO - 'download_minidump_stackwalk': True, 16:05:09 INFO - 'download_symbols': 'ondemand', 16:05:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:05:09 INFO - 'tooltool.py': '/tools/tooltool.py', 16:05:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:05:09 INFO - '/tools/misc-python/virtualenv.py')}, 16:05:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:05:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:05:09 INFO - 'installer_path': 'installer.exe', 16:05:09 INFO - 'log_level': 'info', 16:05:09 INFO - 'log_name': 'talos', 16:05:09 INFO - 'log_to_console': True, 16:05:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:05:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:05:09 INFO - 'opt_config_files': (), 16:05:09 INFO - 'pip_index': False, 16:05:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:05:09 INFO - 'cmd': ('bash', 16:05:09 INFO - '-c', 16:05:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:05:09 INFO - 'enabled': True, 16:05:09 INFO - 'halt_on_failure': False, 16:05:09 INFO - 'name': 'check_screen_resolution'},), 16:05:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:05:09 INFO - 'cmd': ('bash', 16:05:09 INFO - '-c', 16:05:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:05:09 INFO - 'enabled': True, 16:05:09 INFO - 'halt_on_failure': False, 16:05:09 INFO - 'name': 'check_screen_resolution'},), 16:05:09 INFO - 'run_cmd_checks_enabled': True, 16:05:09 INFO - 'sps_profile': False, 16:05:09 INFO - 'sps_profile_interval': 0, 16:05:09 INFO - 'suite': 'dromaeojs', 16:05:09 INFO - 'system_bits': '32', 16:05:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:05:09 INFO - 'title': 't-yosemite-r7-0217', 16:05:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:05:09 INFO - 'use_talos_json': True, 16:05:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:05:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:05:09 INFO - 'work_dir': 'build'} 16:05:09 INFO - [mozharness: 2016-10-19 23:05:09.637686Z] Running clobber step. 16:05:09 INFO - Running pre-action listener: _resource_record_pre_action 16:05:09 INFO - Running main action method: clobber 16:05:09 INFO - rmtree: /builds/slave/test/build 16:05:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:05:11 INFO - Running post-action listener: _resource_record_post_action 16:05:11 INFO - [mozharness: 2016-10-19 23:05:11.835284Z] Finished clobber step (success) 16:05:11 INFO - [mozharness: 2016-10-19 23:05:11.835396Z] Running read-buildbot-config step. 16:05:11 INFO - Running pre-action listener: _resource_record_pre_action 16:05:11 INFO - Running main action method: read_buildbot_config 16:05:11 INFO - Using buildbot properties: 16:05:11 INFO - { 16:05:11 INFO - "project": "", 16:05:11 INFO - "product": "firefox", 16:05:11 INFO - "script_repo_revision": "production", 16:05:11 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:05:11 INFO - "repository": "", 16:05:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:05:11 INFO - "buildid": "20161019135423", 16:05:11 INFO - "pgo_build": "False", 16:05:11 INFO - "basedir": "/builds/slave/test", 16:05:11 INFO - "buildnumber": 93, 16:05:11 INFO - "slavename": "t-yosemite-r7-0217", 16:05:11 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:05:11 INFO - "platform": "yosemite_r7", 16:05:11 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:05:11 INFO - "branch": "mozilla-aurora", 16:05:11 INFO - "repo_path": "releases/mozilla-aurora", 16:05:11 INFO - "revision": "1bb0c02b6c1ce9ed61e2e08b8f37eef5899a7e31", 16:05:11 INFO - "stage_platform": "macosx64", 16:05:11 INFO - "builduid": "7c89bf5e3dbf4249a8a4b0a732a71799", 16:05:11 INFO - "slavebuilddir": "test" 16:05:11 INFO - } 16:05:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:05:11 INFO - Running post-action listener: _resource_record_post_action 16:05:11 INFO - [mozharness: 2016-10-19 23:05:11.838569Z] Finished read-buildbot-config step (success) 16:05:11 INFO - [mozharness: 2016-10-19 23:05:11.838668Z] Running download-and-extract step. 16:05:11 INFO - Running pre-action listener: _resource_record_pre_action 16:05:11 INFO - Running main action method: download_and_extract 16:05:11 INFO - mkdir: /builds/slave/test/build/tests 16:05: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')]} 16:05:11 INFO - trying https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:05:11 INFO - Downloading https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 16:05:12 INFO - Downloaded 1199 bytes. 16:05:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:05:12 INFO - Using the following test package requirements: 16:05:12 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:05:12 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:05:12 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:05:12 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:05:12 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:05:12 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:05:12 INFO - u'jsshell-mac.zip'], 16:05:12 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:05:12 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:05:12 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:05:12 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:05:12 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:05:12 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:05:12 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:05:12 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:05:12 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:05:12 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:05:12 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:05:12 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:05:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:05:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:05:12 INFO - Fetch https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:05:13 INFO - Expected file size: 16436225 16:05:21 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:05:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:05:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:05:21 INFO - Fetch https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:05:21 INFO - Expected file size: 16436225 16:05:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:05:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:05:28 INFO - Fetch https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:05:29 INFO - Expected file size: 14414081 16:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:30 INFO - trying https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:05:30 INFO - Downloading https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:05:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 16:05:33 INFO - Downloaded 115425313 bytes. 16:05:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:05:33 INFO - mkdir: /builds/slave/test/properties 16:05:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:05:33 INFO - Writing to file /builds/slave/test/properties/build_url 16:05:33 INFO - Contents: 16:05:33 INFO - build_url:https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:05:35 INFO - Running post-action listener: _resource_record_post_action 16:05:35 INFO - Running post-action listener: set_extra_try_arguments 16:05:35 INFO - [mozharness: 2016-10-19 23:05:35.073849Z] Finished download-and-extract step (success) 16:05:35 INFO - [mozharness: 2016-10-19 23:05:35.073942Z] Running populate-webroot step. 16:05:35 INFO - Running pre-action listener: _resource_record_pre_action 16:05:35 INFO - Running main action method: populate_webroot 16:05:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:05:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:05:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:05:35 INFO - '--tppagecycles', 16:05:35 INFO - '7'], 16:05:35 INFO - 'tests': ['tsvgm']}}, 16:05:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:05:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:05:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:05:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:05:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:05:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:05:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:35 INFO - 'talos_options': ['--disable-e10s'], 16:05:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:35 INFO - 'talos_options': ['--disable-e10s'], 16:05:35 INFO - 'tests': ['damp', 'tps']}, 16:05:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:35 INFO - 'tests': ['damp', 'tps']}, 16:05:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:05:35 INFO - 'tests': ['dromaeo_dom']}, 16:05:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:05:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:05:35 INFO - 'tests': ['basic_compositor_video']}, 16:05:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:05:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:05:35 INFO - 'tests': ['a11yr', 16:05:35 INFO - 'ts_paint', 16:05:35 INFO - 'tpaint', 16:05:35 INFO - 'sessionrestore', 16:05:35 INFO - 'sessionrestore_no_auto_restore', 16:05:35 INFO - 'tabpaint']}, 16:05:35 INFO - 'other-e10s': {'tests': ['a11yr', 16:05:35 INFO - 'ts_paint', 16:05:35 INFO - 'tpaint', 16:05:35 INFO - 'sessionrestore', 16:05:35 INFO - 'sessionrestore_no_auto_restore', 16:05:35 INFO - 'tabpaint']}, 16:05:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:05:35 INFO - 'ts_paint', 16:05:35 INFO - 'tpaint', 16:05:35 INFO - 'sessionrestore', 16:05:35 INFO - 'sessionrestore_no_auto_restore', 16:05:35 INFO - 'tabpaint']}, 16:05:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:05:35 INFO - 'ts_paint', 16:05:35 INFO - 'tpaint', 16:05:35 INFO - 'sessionrestore', 16:05:35 INFO - 'sessionrestore_no_auto_restore', 16:05:35 INFO - 'tabpaint']}, 16:05:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:05:35 INFO - 'tests': ['a11yr', 16:05:35 INFO - 'ts_paint', 16:05:35 INFO - 'tpaint', 16:05:35 INFO - 'sessionrestore', 16:05:35 INFO - 'sessionrestore_no_auto_restore', 16:05:35 INFO - 'tabpaint']}, 16:05:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:05:35 INFO - 'tests': ['a11yr', 16:05:35 INFO - 'ts_paint', 16:05:35 INFO - 'tpaint', 16:05:35 INFO - 'sessionrestore', 16:05:35 INFO - 'sessionrestore_no_auto_restore', 16:05:35 INFO - 'tabpaint']}, 16:05:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:05:35 INFO - 'tests': ['tsvgx', 16:05:35 INFO - 'tsvgr_opacity', 16:05:35 INFO - 'tart', 16:05:35 INFO - 'tscrollx', 16:05:35 INFO - 'cart']}, 16:05:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:05:35 INFO - 'tsvgr_opacity', 16:05:35 INFO - 'tart', 16:05:35 INFO - 'tscrollx', 16:05:35 INFO - 'cart']}, 16:05:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:35 INFO - 'talos_options': ['--disable-e10s'], 16:05:35 INFO - 'tests': ['tp5o']}, 16:05:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:35 INFO - 'tests': ['tp5o']}, 16:05:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:35 INFO - 'talos_options': ['--disable-e10s', 16:05:35 INFO - '--xperf_path', 16:05:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:35 INFO - 'tests': ['tp5n']}, 16:05:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:35 INFO - 'talos_options': ['--xperf_path', 16:05:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:35 INFO - 'tests': ['tp5n']}}, 16:05:35 INFO - 'talos.zip': {'path': '', 16:05:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:05:35 INFO - Running post-action listener: _resource_record_post_action 16:05:35 INFO - [mozharness: 2016-10-19 23:05:35.093080Z] Finished populate-webroot step (success) 16:05:35 INFO - [mozharness: 2016-10-19 23:05:35.093220Z] Running create-virtualenv step. 16:05:35 INFO - Running pre-action listener: _resource_record_pre_action 16:05:35 INFO - Running main action method: create_virtualenv 16:05:35 INFO - Creating virtualenv /builds/slave/test/build/venv 16:05:35 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 16:05:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:05:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:05:35 INFO - Using real prefix '/tools/python27' 16:05:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:05:35 INFO - Installing distribute.............................................................................................................................................................................................done. 16:05:38 INFO - Installing pip.................done. 16:05:38 INFO - Return code: 0 16:05:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104022490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd239dd0c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e36d30>, '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 0x103c9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e2eb20>, '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.GAvRJvkgAo/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.94LhLQVA28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:05:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GAvRJvkgAo/Render', 16:05:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:38 INFO - 'HOME': '/Users/cltbld', 16:05:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:38 INFO - 'LOGNAME': 'cltbld', 16:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:38 INFO - 'MOZ_NO_REMOTE': '1', 16:05:38 INFO - 'NO_EM_RESTART': '1', 16:05:38 INFO - 'PAGER': '/bin/cat', 16:05:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:38 INFO - 'PWD': '/builds/slave/test', 16:05:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:38 INFO - 'SHELL': '/bin/bash', 16:05:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94LhLQVA28/Listeners', 16:05:38 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:05:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:38 INFO - 'USER': 'cltbld', 16:05:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:38 INFO - 'XPC_FLAGS': '0x0', 16:05:38 INFO - 'XPC_SERVICE_NAME': '0', 16:05:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:39 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 16:05:39 INFO - Cleaning up... 16:05:39 INFO - Return code: 0 16:05:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104022490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd239dd0c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e36d30>, '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 0x103c9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e2eb20>, '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.GAvRJvkgAo/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.94LhLQVA28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:05:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GAvRJvkgAo/Render', 16:05:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:39 INFO - 'HOME': '/Users/cltbld', 16:05:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:39 INFO - 'LOGNAME': 'cltbld', 16:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:39 INFO - 'MOZ_NO_REMOTE': '1', 16:05:39 INFO - 'NO_EM_RESTART': '1', 16:05:39 INFO - 'PAGER': '/bin/cat', 16:05:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:39 INFO - 'PWD': '/builds/slave/test', 16:05:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:39 INFO - 'SHELL': '/bin/bash', 16:05:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94LhLQVA28/Listeners', 16:05:39 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:05:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:39 INFO - 'USER': 'cltbld', 16:05:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:39 INFO - 'XPC_FLAGS': '0x0', 16:05:39 INFO - 'XPC_SERVICE_NAME': '0', 16:05:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:39 INFO - Downloading/unpacking psutil>=3.1.1 16:05:39 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 16:05:39 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 16:05:39 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 16:05:39 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 16:05:39 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 16:05:39 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 16:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:42 INFO - Installing collected packages: psutil 16:05:42 INFO - Running setup.py install for psutil 16:05:42 INFO - building 'psutil._psutil_osx' extension 16:05:42 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 16:05:43 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 16:05:43 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 16:05:43 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 16:05:43 INFO - building 'psutil._psutil_posix' extension 16:05:43 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 16:05:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:05:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:05:43 INFO - ^ 16:05:43 INFO - 1 warning generated. 16:05:43 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 16:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:44 INFO - Successfully installed psutil 16:05:44 INFO - Cleaning up... 16:05:44 INFO - Return code: 0 16:05:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:05:44 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')]} 16:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:44 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')]} 16:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:44 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 0x104022490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd239dd0c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e36d30>, '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 0x103c9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e2eb20>, '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.GAvRJvkgAo/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.94LhLQVA28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:05:44 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 16:05:44 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 16:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GAvRJvkgAo/Render', 16:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:44 INFO - 'HOME': '/Users/cltbld', 16:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:44 INFO - 'LOGNAME': 'cltbld', 16:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:44 INFO - 'MOZ_NO_REMOTE': '1', 16:05:44 INFO - 'NO_EM_RESTART': '1', 16:05:44 INFO - 'PAGER': '/bin/cat', 16:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:44 INFO - 'PWD': '/builds/slave/test', 16:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:44 INFO - 'SHELL': '/bin/bash', 16:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94LhLQVA28/Listeners', 16:05:44 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:44 INFO - 'USER': 'cltbld', 16:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:44 INFO - 'XPC_FLAGS': '0x0', 16:05:44 INFO - 'XPC_SERVICE_NAME': '0', 16:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:05:47 INFO - Installing collected packages: mozsystemmonitor 16:05:47 INFO - Running setup.py install for mozsystemmonitor 16:05:47 INFO - Successfully installed mozsystemmonitor 16:05:47 INFO - Cleaning up... 16:05:47 INFO - Return code: 0 16:05:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104022490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd239dd0c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e36d30>, '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 0x103c9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e2eb20>, '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.GAvRJvkgAo/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.94LhLQVA28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:05:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GAvRJvkgAo/Render', 16:05:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:47 INFO - 'HOME': '/Users/cltbld', 16:05:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:47 INFO - 'LOGNAME': 'cltbld', 16:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:47 INFO - 'MOZ_NO_REMOTE': '1', 16:05:47 INFO - 'NO_EM_RESTART': '1', 16:05:47 INFO - 'PAGER': '/bin/cat', 16:05:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:47 INFO - 'PWD': '/builds/slave/test', 16:05:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:47 INFO - 'SHELL': '/bin/bash', 16:05:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94LhLQVA28/Listeners', 16:05:47 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:05:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:47 INFO - 'USER': 'cltbld', 16:05:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:47 INFO - 'XPC_FLAGS': '0x0', 16:05:47 INFO - 'XPC_SERVICE_NAME': '0', 16:05:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:47 INFO - Downloading/unpacking jsonschema==2.5.1 16:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:05:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:50 INFO - Downloading functools32-3.2.3-2.tar.gz 16:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:05:50 INFO - warning: no files found matching '*.txt' 16:05:50 INFO - no previously-included directories found matching 'build' 16:05:50 INFO - no previously-included directories found matching 'dist' 16:05:50 INFO - no previously-included directories found matching '.git*' 16:05:50 INFO - Installing collected packages: jsonschema, functools32 16:05:50 INFO - Running setup.py install for functools32 16:05:50 INFO - warning: no files found matching '*.txt' 16:05:50 INFO - no previously-included directories found matching 'build' 16:05:50 INFO - no previously-included directories found matching 'dist' 16:05:50 INFO - no previously-included directories found matching '.git*' 16:05:50 INFO - Successfully installed jsonschema functools32 16:05:50 INFO - Cleaning up... 16:05:50 INFO - Return code: 0 16:05:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:05:50 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')]} 16:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:50 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')]} 16:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:50 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 0x104022490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd239dd0c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e36d30>, '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 0x103c9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e2eb20>, '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.GAvRJvkgAo/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.94LhLQVA28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:05:50 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 16:05:50 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 16:05:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GAvRJvkgAo/Render', 16:05:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:50 INFO - 'HOME': '/Users/cltbld', 16:05:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:50 INFO - 'LOGNAME': 'cltbld', 16:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:50 INFO - 'MOZ_NO_REMOTE': '1', 16:05:50 INFO - 'NO_EM_RESTART': '1', 16:05:50 INFO - 'PAGER': '/bin/cat', 16:05:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:50 INFO - 'PWD': '/builds/slave/test', 16:05:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:50 INFO - 'SHELL': '/bin/bash', 16:05:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94LhLQVA28/Listeners', 16:05:50 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:05:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:50 INFO - 'USER': 'cltbld', 16:05:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:50 INFO - 'XPC_FLAGS': '0x0', 16:05:50 INFO - 'XPC_SERVICE_NAME': '0', 16:05:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:05:51 INFO - Cleaning up... 16:05:51 INFO - Return code: 0 16:05:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:05:51 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')]} 16:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:51 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')]} 16:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:51 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 0x104022490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd239dd0c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e36d30>, '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 0x103c9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e2eb20>, '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.GAvRJvkgAo/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.94LhLQVA28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:05:51 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 16:05:51 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 16:05:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GAvRJvkgAo/Render', 16:05:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:51 INFO - 'HOME': '/Users/cltbld', 16:05:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:51 INFO - 'LOGNAME': 'cltbld', 16:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:51 INFO - 'MOZ_NO_REMOTE': '1', 16:05:51 INFO - 'NO_EM_RESTART': '1', 16:05:51 INFO - 'PAGER': '/bin/cat', 16:05:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:51 INFO - 'PWD': '/builds/slave/test', 16:05:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:51 INFO - 'SHELL': '/bin/bash', 16:05:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94LhLQVA28/Listeners', 16:05:51 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:05:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:51 INFO - 'USER': 'cltbld', 16:05:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:51 INFO - 'XPC_FLAGS': '0x0', 16:05:51 INFO - 'XPC_SERVICE_NAME': '0', 16:05:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:51 INFO - Downloading/unpacking blobuploader==1.2.4 16:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:53 INFO - Downloading blobuploader-1.2.4.tar.gz 16:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:05:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:05:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:55 INFO - Downloading docopt-0.6.1.tar.gz 16:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:05:55 INFO - Installing collected packages: blobuploader, requests, docopt 16:05:55 INFO - Running setup.py install for blobuploader 16:05:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:05:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:05:55 INFO - Running setup.py install for requests 16:05:55 INFO - Running setup.py install for docopt 16:05:56 INFO - Successfully installed blobuploader requests docopt 16:05:56 INFO - Cleaning up... 16:05:56 INFO - Return code: 0 16:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:56 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 0x104022490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd239dd0c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e36d30>, '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 0x103c9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e2eb20>, '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.GAvRJvkgAo/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.94LhLQVA28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:05:56 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 16:05:56 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 16:05:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GAvRJvkgAo/Render', 16:05:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:56 INFO - 'HOME': '/Users/cltbld', 16:05:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:56 INFO - 'LOGNAME': 'cltbld', 16:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:56 INFO - 'MOZ_NO_REMOTE': '1', 16:05:56 INFO - 'NO_EM_RESTART': '1', 16:05:56 INFO - 'PAGER': '/bin/cat', 16:05:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:56 INFO - 'PWD': '/builds/slave/test', 16:05:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:56 INFO - 'SHELL': '/bin/bash', 16:05:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94LhLQVA28/Listeners', 16:05:56 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:05:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:56 INFO - 'USER': 'cltbld', 16:05:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:56 INFO - 'XPC_FLAGS': '0x0', 16:05:56 INFO - 'XPC_SERVICE_NAME': '0', 16:05:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-eRI6xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-jV_doa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-wWJ_NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-LVDzJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-6Qz9R8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-58x9F0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-L02Lrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-KoBsHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-lEMsOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-_KFNDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-k6EO3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-72p9ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-rSbpyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-58BbHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-XKdqA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-RExYIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:58 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-kCo6_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:05:58 INFO - Running setup.py install for manifestparser 16:05:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:05:58 INFO - Running setup.py install for mozcrash 16:05:58 INFO - Running setup.py install for mozdebug 16:05:58 INFO - Running setup.py install for mozdevice 16:05:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:05:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:05:58 INFO - Running setup.py install for mozfile 16:05:58 INFO - Running setup.py install for mozhttpd 16:05:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:05:59 INFO - Running setup.py install for mozinfo 16:05:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:05:59 INFO - Running setup.py install for mozInstall 16:05:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:05:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:05:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:05:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:05:59 INFO - Running setup.py install for mozleak 16:05:59 INFO - Running setup.py install for mozlog 16:05:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:05:59 INFO - Running setup.py install for moznetwork 16:05:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:05:59 INFO - Running setup.py install for mozprocess 16:05:59 INFO - Running setup.py install for mozprofile 16:06:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:06:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:06:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:06:00 INFO - Running setup.py install for mozrunner 16:06:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:06:00 INFO - Running setup.py install for mozscreenshot 16:06:00 INFO - Running setup.py install for moztest 16:06:00 INFO - Running setup.py install for mozversion 16:06:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:06:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:06:00 INFO - Cleaning up... 16:06:00 INFO - Return code: 0 16:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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')]} 16:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:00 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 0x104022490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd239dd0c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e36d30>, '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 0x103c9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e2eb20>, '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.GAvRJvkgAo/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.94LhLQVA28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:06:00 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 16:06:00 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 16:06:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GAvRJvkgAo/Render', 16:06:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:00 INFO - 'HOME': '/Users/cltbld', 16:06:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:00 INFO - 'LOGNAME': 'cltbld', 16:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:00 INFO - 'MOZ_NO_REMOTE': '1', 16:06:00 INFO - 'NO_EM_RESTART': '1', 16:06:00 INFO - 'PAGER': '/bin/cat', 16:06:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:00 INFO - 'PWD': '/builds/slave/test', 16:06:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:00 INFO - 'SHELL': '/bin/bash', 16:06:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94LhLQVA28/Listeners', 16:06:00 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:06:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:00 INFO - 'USER': 'cltbld', 16:06:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:00 INFO - 'XPC_FLAGS': '0x0', 16:06:00 INFO - 'XPC_SERVICE_NAME': '0', 16:06:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-V0rtcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:01 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)) 16:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-ngbW0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 16:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-GKYouA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:01 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)) 16:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-ja57A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 16:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-7_duVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:01 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)) 16:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-YRy7R4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:01 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)) 16:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-FX_B4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:01 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)) 16:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-U18zrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:01 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)) 16:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-5_VN3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:01 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)) 16:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-b4fT7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:02 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)) 16:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-O4Sx_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:02 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)) 16:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-s5to5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 16:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-wqhpMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:02 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)) 16:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-wW3_Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 16:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-DsnZLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:02 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)) 16:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-665qP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 16:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-x8Ef9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:02 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)) 16:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:06:02 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)) 16:06:02 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:06:02 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:06:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:06:02 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 16:06:02 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 16:06:02 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 16:06:02 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 16:06:02 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 16:06:02 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 16:06:05 INFO - Downloading blessings-1.6.tar.gz 16:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:06:05 INFO - Installing collected packages: blessings 16:06:05 INFO - Running setup.py install for blessings 16:06:05 INFO - Successfully installed blessings 16:06:05 INFO - Cleaning up... 16:06:05 INFO - Return code: 0 16:06:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:06 INFO - Reading from file tmpfile_stdout 16:06:06 INFO - Current package versions: 16:06:06 INFO - blessings == 1.6 16:06:06 INFO - blobuploader == 1.2.4 16:06:06 INFO - docopt == 0.6.1 16:06:06 INFO - functools32 == 3.2.3-2 16:06:06 INFO - jsonschema == 2.5.1 16:06:06 INFO - manifestparser == 1.1 16:06:06 INFO - mozInstall == 1.12 16:06:06 INFO - mozcrash == 0.17 16:06:06 INFO - mozdebug == 0.1 16:06:06 INFO - mozdevice == 0.48 16:06:06 INFO - mozfile == 1.2 16:06:06 INFO - mozhttpd == 0.7 16:06:06 INFO - mozinfo == 0.9 16:06:06 INFO - mozleak == 0.1 16:06:06 INFO - mozlog == 3.4 16:06:06 INFO - moznetwork == 0.27 16:06:06 INFO - mozprocess == 0.23 16:06:06 INFO - mozprofile == 0.28 16:06:06 INFO - mozrunner == 6.12 16:06:06 INFO - mozscreenshot == 0.1 16:06:06 INFO - mozsystemmonitor == 0.3 16:06:06 INFO - moztest == 0.7 16:06:06 INFO - mozversion == 1.4 16:06:06 INFO - psutil == 3.1.1 16:06:06 INFO - requests == 1.2.3 16:06:06 INFO - wsgiref == 0.1.2 16:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:06 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')]} 16:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:06 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')]} 16:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:06 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 0x104022490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd239dd0c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e36d30>, '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 0x103c9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e2eb20>, '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.GAvRJvkgAo/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.94LhLQVA28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:06:06 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 16:06:06 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 16:06:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GAvRJvkgAo/Render', 16:06:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:06 INFO - 'HOME': '/Users/cltbld', 16:06:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:06 INFO - 'LOGNAME': 'cltbld', 16:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:06 INFO - 'MOZ_NO_REMOTE': '1', 16:06:06 INFO - 'NO_EM_RESTART': '1', 16:06:06 INFO - 'PAGER': '/bin/cat', 16:06:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:06 INFO - 'PWD': '/builds/slave/test', 16:06:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:06 INFO - 'SHELL': '/bin/bash', 16:06:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94LhLQVA28/Listeners', 16:06:06 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:06:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:06 INFO - 'USER': 'cltbld', 16:06:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:06 INFO - 'XPC_FLAGS': '0x0', 16:06:06 INFO - 'XPC_SERVICE_NAME': '0', 16:06:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 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)) 16:06:06 INFO - Cleaning up... 16:06:06 INFO - Return code: 0 16:06:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:06:06 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')]} 16:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:06 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')]} 16:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:06 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 0x104022490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd239dd0c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e36d30>, '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 0x103c9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e2eb20>, '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.GAvRJvkgAo/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.94LhLQVA28/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:06:06 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 16:06:06 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 16:06:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GAvRJvkgAo/Render', 16:06:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:06 INFO - 'HOME': '/Users/cltbld', 16:06:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:06 INFO - 'LOGNAME': 'cltbld', 16:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:06 INFO - 'MOZ_NO_REMOTE': '1', 16:06:06 INFO - 'NO_EM_RESTART': '1', 16:06:06 INFO - 'PAGER': '/bin/cat', 16:06:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:06 INFO - 'PWD': '/builds/slave/test', 16:06:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:06 INFO - 'SHELL': '/bin/bash', 16:06:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94LhLQVA28/Listeners', 16:06:06 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:06:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:06 INFO - 'USER': 'cltbld', 16:06:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:06 INFO - 'XPC_FLAGS': '0x0', 16:06:06 INFO - 'XPC_SERVICE_NAME': '0', 16:06:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:06:06 INFO - Cleaning up... 16:06:07 INFO - Return code: 0 16:06:07 INFO - Running post-action listener: _resource_record_post_action 16:06:07 INFO - Running post-action listener: _start_resource_monitoring 16:06:07 INFO - Starting resource monitoring. 16:06:07 INFO - [mozharness: 2016-10-19 23:06:07.037727Z] Finished create-virtualenv step (success) 16:06:07 INFO - [mozharness: 2016-10-19 23:06:07.038702Z] Running install step. 16:06:07 INFO - Running pre-action listener: _resource_record_pre_action 16:06:07 INFO - Running main action method: install 16:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:07 INFO - Reading from file tmpfile_stdout 16:06:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:06:07 INFO - Reading from file tmpfile_stdout 16:06:07 INFO - Output received: 16:06:07 INFO - Usage: mozinstall [options] installer 16:06:07 INFO - Options: 16:06:07 INFO - -h, --help show this help message and exit 16:06:07 INFO - -d DEST, --destination=DEST 16:06:07 INFO - Directory to install application into. [default: 16:06:07 INFO - "/builds/slave/test"] 16:06:07 INFO - --app=APP Application being installed. [default: firefox] 16:06:07 INFO - mkdir: /builds/slave/test/build/application 16:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:06:39 INFO - Reading from file tmpfile_stdout 16:06:39 INFO - Output received: 16:06:39 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:06:39 INFO - Running post-action listener: _resource_record_post_action 16:06:39 INFO - [mozharness: 2016-10-19 23:06:39.337516Z] Finished install step (success) 16:06:39 INFO - [mozharness: 2016-10-19 23:06:39.337644Z] Running run-tests step. 16:06:39 INFO - Running pre-action listener: _resource_record_pre_action 16:06:39 INFO - Running main action method: run_tests 16:06:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:06:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:06:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:06:39 INFO - 2016-10-19 16:06:39.352 screenresolution[1635:7491] starting screenresolution argv=screenresolution get 16:06:39 INFO - 2016-10-19 16:06:39.355 screenresolution[1635:7491] Display 0: 1600x1200x32@60 16:06:39 INFO - 2016-10-19 16:06:39.361 screenresolution[1636:7496] starting screenresolution argv=screenresolution list 16:06:39 INFO - Available Modes on Display 0 16:06:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:06:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:06:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:06:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:06:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:06:39 INFO - Intel Iris: 16:06:39 INFO - Chipset Model: Intel Iris 16:06:39 INFO - Type: GPU 16:06:39 INFO - Bus: Built-In 16:06:39 INFO - VRAM (Dynamic, Max): 1536 MB 16:06:39 INFO - Vendor: Intel (0x8086) 16:06:39 INFO - Device ID: 0x0a2e 16:06:39 INFO - Revision ID: 0x0009 16:06:39 INFO - Displays: 16:06:39 INFO - Display: 16:06:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:06:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:06:39 INFO - Display Serial Number: 1600x1200 60 16:06:39 INFO - Main Display: Yes 16:06:39 INFO - Mirror: Off 16:06:39 INFO - Online: Yes 16:06:39 INFO - Rotation: Supported 16:06:39 INFO - Return code: 0 16:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:06:39 INFO - Python 2.7.3 16:06:39 INFO - Return code: 0 16:06:39 INFO - grabbing minidump binary from tooltool 16:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:39 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 0x103e36d30>, '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 0x103c9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e2eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:06:39 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 16:06:39 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 16:06:39 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 16:06:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:06:39 INFO - Return code: 0 16:06:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:06:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:06:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:06:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:06:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--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 16:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0217 --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 16:06:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GAvRJvkgAo/Render', 16:06:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:39 INFO - 'HOME': '/Users/cltbld', 16:06:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:39 INFO - 'LOGNAME': 'cltbld', 16:06:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:06:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:39 INFO - 'MOZ_NO_REMOTE': '1', 16:06:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:06:39 INFO - 'NO_EM_RESTART': '1', 16:06:39 INFO - 'PAGER': '/bin/cat', 16:06:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:39 INFO - 'PWD': '/builds/slave/test', 16:06:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:06:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:39 INFO - 'SHELL': '/bin/bash', 16:06:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.94LhLQVA28/Listeners', 16:06:39 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:06:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:39 INFO - 'USER': 'cltbld', 16:06:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:39 INFO - 'XPC_FLAGS': '0x0', 16:06:39 INFO - 'XPC_SERVICE_NAME': '0', 16:06:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--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 16:06:39 INFO - mozversion application_buildid: 20161019135423 16:06:39 INFO - mozversion application_changeset: 1bb0c02b6c1ce9ed61e2e08b8f37eef5899a7e31 16:06:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:06:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:06:39 INFO - mozversion application_name: Firefox 16:06:39 INFO - mozversion application_remotingname: firefox-dev 16:06:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:06:39 INFO - mozversion application_vendor: Mozilla 16:06:39 INFO - mozversion application_version: 51.0a2 16:06:39 INFO - mozversion platform_buildid: 20161019135423 16:06:39 INFO - mozversion platform_changeset: 1bb0c02b6c1ce9ed61e2e08b8f37eef5899a7e31 16:06:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:06:39 INFO - mozversion platform_version: 51.0a2 16:06:39 INFO - using testdate: 1476918399 16:06:39 INFO - actual date: 1476918399 16:06:39 INFO - starting webserver on 'localhost:49271' 16:06:39 INFO - SUITE-START | Running 2 tests 16:06:39 INFO - TEST-START | dromaeo_css 16:06:39 INFO - operating with platform_type : mac_ 16:06:39 INFO - Initialising browser for dromaeo_css test... 16:06:39 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpuO6xbw/profile http://localhost:49271/getInfo.html) 16:06:42 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 16:06:42 INFO - PROCESS | 1646 | colorDepth:24 16:06:42 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 16:06:42 INFO - PROCESS | 1646 | __metrics 16:06:42 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:06:42 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:06:43 INFO - TEST-INFO | 1646: exit 0 16:06:43 INFO - Browser initialized. 16:06:43 INFO - Running cycle 1/1 for dromaeo_css test... 16:06:43 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpuO6xbw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:55 INFO - PROCESS | 1648 | RSS: Main: 219701248 16:06:55 INFO - PROCESS | 1648 | 16:07:46 INFO - PROCESS | 1648 | 1476918466185 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:09:57 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 16:09:58 INFO - PROCESS | 1648 | RSS: Main: 359952384 16:09:58 INFO - PROCESS | 1648 | 16:13:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 16:13:02 INFO - PROCESS | 1648 | RSS: Main: 358236160 16:13:02 INFO - PROCESS | 1648 | 16:16:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 16:16:05 INFO - PROCESS | 1648 | RSS: Main: 345612288 16:16:05 INFO - PROCESS | 1648 | 16:19:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 16:19:08 INFO - PROCESS | 1648 | RSS: Main: 329555968 16:19:08 INFO - PROCESS | 1648 | 16:22:11 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 16:22:11 INFO - PROCESS | 1648 | RSS: Main: 307531776 16:22:11 INFO - PROCESS | 1648 | 16:25:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 16:25:15 INFO - PROCESS | 1648 | RSS: Main: 460668928 16:25:15 INFO - PROCESS | 1648 | 16:25:15 INFO - PROCESS | 1648 | __start_tp_report 16:25:15 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 16:25:15 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 16:25:15 INFO - PROCESS | 1648 | |i|pagename|runs| 16:25:15 INFO - PROCESS | 1648 | |0;dojo.html;2798.9020384286546;3225.8064516129025;3236.3365510070425;3247.2693643930133;3286.326303107863;5430.782768689252;5474.288342515468;5507.531859791918;5521.2270282160525;5534.584906132036;5454.400015998237;5511.834644960658;5515.7242137893145;5517.144842549411;5541.861453463665;5005.524475174861;5017.322661440713;5045.4702256262935;5112.488751124895;5136.64043516954;4954.43024052235;5026.623003274751;5032.899342013157;5050.823221187259;5146.922796158061;5141.614378921578;5147.202183661539;5156.896862062757;5157.200633901752;5174.990876779029;5140.8714782130555;5143.974280128576;5147.330846989905;5152.175651895697;5195.870103247411;4960.925586116211;4962.255661650745;5080.644354895159;5109.923351149736;5111.8466446006305;5377.435369286247;5496.725163741837;5498.45015498451;5514.972425137848;5517.36550296717;5890.646561206298;5900.793472228452;5912.615679980788;5951.9107213391835;6007.909881351783;6050.2437195350585;6081.11823785553;6081.209442772455;6083;6095.146679464879;5394.514493695547;5507.834764957058;5521.641093328921;5523.171524271392;5575.8884822303735;5097.235414687826;6125.021800333839;6193.318734939153;6214.533909956771;6234.719437625317;5727.513161381329;5878.177055212273;5896.292444906639;5901.881962360729;5906.970465147647;5876.324222714357;5941.792037278675;5976;6026;6031.2159419276095;5876.676782776988;5919.289685237713;5927.673977931255;5943.524518038546;5948.881022379528;5930.199423077829;5996.640201587918;6015.729292181863;6035.637861728311;6060.787872424532;4782.056074766355;4829.710217386968;4831.782569784298;4838.153323168432;4854.247591623304;4237.978810105929;4272.700910936204;4286.914261714811;4340.674449416307;4350.456192975878;5557.9995600792245;5609.495145436848;5629.943700563023;5664.688442135722;5696.3733989261145;6097.359777223416;6105.206323177958;6105.511559075263;6109.877802443926;6124.693765311717;5411;5612.326520817528;5637.887242255132;5654.943450565524;5660.29246344207;4441.800118994653;5137.8715532112;5151.562117220078;5202.76587553561;5220.216967454912;6184.907226391608;6187.783427580013;6195.19462469876;6204.007358822567;6215.378462153839;6006.399360063959;6013.06797446379;6017.518598512021;6029.969850150721;6088.969555152196;6004.789832355847;6132.324915438686;6136.274005701014;6137.039921714347;6190;5909.08409196558;5969.701514924323;5977.820665380045;5998.760049597967;6010.519158467399;6030.90953635687;6067.302260240129;6070.575059745952;6083.117947897618;6097.420745029215;5526.834194974157;5760.740766665426;5828.94171058301;5868.911966320594;5889.087191485327;5769.884602308014;5770.13447982806;5836.649801011953;5873.4126587340925;5910.940890591039;5717.37108918027;5747.367789543064;5768.365479797303;5772.538196944319;5779.682117483579;5663.490285874291;5838.12428135783;5841.737121829443;5855.268091488564;5868.2077919482035;5661.971690141688;5685.459881311269;5725.341585717696;5750.597458177887;5813.069908814569 16:25:15 INFO - PROCESS | 1648 | |1;ext.html;477.6966626192368;478.868311214416;497.2764627467036;525.4062908912928;534.9277847490588;31477.527837082434;41968.79015604922;42942.99999999996;43029.7848510757;45573;44305;44496.555034449644;44547.55452445475;44663.33005004928;44720.77639611797;9788.41269523829;9968.202543796478;9984.950075249613;9985.40087594743;9987.900120998806;8802.427842190236;9024.097590240955;12036.518539258463;12288;12351;12261.93869030658;12332.321722305269;12356.814647780291;12357.876421235807;12386.752264954695;12269.325187114706;12336.074794390366;12341.75316493665;12351.814722779165;12352.505899763999;12109.576164834189;12201.816972745415;12206.816897746541;12215.694607634792;12227.449764760608;41564.79217603893;41788.37317440241;41789.37315940263;41808;41859.79070104661;3456.343294773985;3547.609762926076;3952.446657467957;3985.4818873546255;4014.297497937849;29323.560146597818;30076.24809379761;30104.397912041855;31299.374012519624;32132.518012229837;3145.6067991501063;3181.602299712536;3273.918152046194;3314.8342582871;3322.7175690066374;523909.9999999962;531544;532654;532657;533147;63931;64043.6797816008;64257.357426426075;64310;64313.03530447047;67796;67818;67820;67859.66070169618;67983.32016679869;17050.74423883643;17238.310467581407;17265.223064962105;17271.56821079458;17312.394066207624;9887.851682224773;12145.210561313486;13135.934320328528;13239.139455935527;13268.203907765565;16119.516414507583;16207.837921620632;16227.594310142105;16253.593660158354;16261.105639189958;6420.6468644225015;7032.331928466788;7351.8604616284565;8465.534395608178;8718.694845680371;834.4576025583419;904.8009437923646;915.7252824152728;918.7794929217074;998.2014388489325;29436.116916492538;29459;29492.705072949426;30352.634131464136;30441.543376849364;974.8732664753678;1051.7686109055996;1068.9679309620724;1083.3608171179042;1133.5352505472881;15340;15493;15780.763288550681;15903.840961590467;16202.594935126715;627447;679585;698144;699000;703717;59970.70014649986;60441.395586043574;60476.09285860715;60480.69759651174;60608;1237.6348977051791;1270.733146039342;1352.959411217665;1374.2304309586664;1391.325207274471;26530.071447499246;29513.85243073771;31664.841675791475;32365.51451728273;32987.67012329846;58245;59090.40909591021;62912;62968;63208.683956579924;658775;668045;669284;669861;672517;38392.80803595964;43718.125637487705;45910.31134532918;46252.768736156104;48394.75802621105;48863.755681221366;49461.01077978492;49833;49994.50005500044;50201.99596008132;39429.802850985565;40703.59296406998;41515.37726934159;41954.37068444037;42206.366904497074;40618.9845253871;40684.59315406808;40909.38635920523;41661.33354665779;42334.7883260594;39301.21397571975;40143.799281003405;40655.983600410225;40914.590854091075;42062.948426289586;32013;35881;36452.45321320235;36827.81586092053;36875;26130.86934565315;26171.607425889008;26365.472690546467;26461;26777.598336025363 16:25:15 INFO - PROCESS | 1648 | |2;jquery.html;358.9874354397597;370.8998570385995;376.4485029431884;385.63172170577104;404.2743275819903;15423.922880385597;15562.299696513655;17786.91106544467;20649.896750516265;20966.580668386625;19573.21707131713;19664;20271.39185824424;20319.288824891093;20619.484512887186;5115;5854.795082172135;6000.429959153874;6121.571489995702;6132.110843927628;6809.557378770364;6862.691178896936;6877.7592784252565;6896.827579310508;6936.028955946172;6549.967250163742;6813.863722725542;6828.146481689789;6835.965820170893;6871.450283977295;5778.7688492460675;6744.055832183473;6772.8306792330095;6782.626955517445;6783.457323414115;5850.76596936122;5987.461128498456;5988.970055149696;5994.970025149846;6003.399660034005;10739.731506712316;12783;12858.906992905615;13019.414126364336;13149.342532873317;2064.5870825834895;2209.3151123151715;2319.5476882008015;2567.5763499022637;2654.6814382274056;9498.9525052375;9816.214702823758;10267.43529105899;10312.845307320396;10342.276040677156;1818.809025052377;1840.2638944422204;1840.5858681796622;1876.990615046916;1880.304287413652;83809.99999999939;86866.13133868643;91495;119607.4019629905;119794.40102799518;10588.894111058791;11376.260543064674;11610.419479026015;11723.41382930867;11727.824082638766;14330.928345358416;14573.708525829425;14581.562553123424;14602.488912887999;14613.78079328811;6288.811335659938;6576.835579110465;6607.108040414579;8049.235322644339;8524.36067294943;8555.486670799772;8560.61477233526;8671.956640216884;8676.739697809076;8726.781830454163;4392.253316936129;4458.687891847604;4484.551544845489;4504.754358161622;4554.681172317973;1693.3903794633923;1895.3555791031115;1913.9330123445613;1927.6461640934904;1949.3859434278156;693.6566399632113;826.3306721555559;971.9902800972042;999.0908273471251;1024.8843910602402;11255.324680519196;11316.26444281119;11511.366874821964;11831;11833.585824496102;382.22599236546216;428.661357527556;431.40250752707726;436.00373147358135;444.51103785835966;5855.443732845373;5984.551158663117;9726.70819875405;11374.014528522375;11513.827292590451;553424;631776;644563;647974;660209;90618.4041818725;133842.17050543928;137395;138965;142419;409.4186255517173;445.465441470237;445.692472194185;446.5155306492427;446.5266817173806;9140.542972851197;11093.500792464198;11186.32882027081;11773.529058837894;11792.941035294769;55275.723621381636;55714;56154.719226403606;56837;57274.78307647875;75936.11622468692;77845.83231251649;78656;78980;79769.20230797617;7976.9202307976175;8155.429119961545;8376.874346884924;8482.533460659723;8508.74473765788;11199.384033878216;12631.494740210288;12632.557860474839;13058.673533161747;13078.084534082524;11004.779904402027;11053.11575073976;11360.943195283971;11374.31754094757;11599.536018559163;10251.231157663056;10433.217508686726;11094.722631934266;11135.33188008722;11207.831882521605;9469;11188.04901583342;11328.716782080184;11413.258138220988;11450.94274528622;7094.432445404458;7921.9207807923485;7973.760787176394;8295.668173273243;8546.615402306787;8148.266656000988;10265.12746416533;11055.336679799238;11133.276337038067;11423.257488263569 16:25:15 INFO - PROCESS | 1648 | |3;mootools.html;1406.3671347893448;1507.9999999999995;1677.9496615101543;1709.8373106287736;1844.4835446075094;7992.880106798395;9022.819543609132;9041.638334466621;9049.95475022624;9051.954740226289;7833;8027.478213916092;8033.517988920669;8581.442206256588;8805.25155361795;2336.7546407627165;2385.7256415512265;2388.8088952883727;2390.426297688551;2393.2222027840935;2393;2407.9398015049587;2414.022320960014;2424.793892519138;2426.38127277544;2195.6047911375945;2261.3555136786017;2377.6552399902002;2401.651760494727;2408.0247499762536;2361.9645705314433;2364.3498038039506;2376.893039813195;2379.7501262367464;2382.8808559572126;2121.0349291072525;2272.1138755885218;2324.569954558412;2377.738448770634;2378.9167379141645;8904.243139333164;8932.10678932108;8954;8961.148690874421;8973.506457144855;4382.9342559861625;5356.758945847446;5370.516653501204;5372.489613486712;5373.811916582901;3498.177928186874;3567.0547304964207;3696.7597106188014;3699.186179040607;3705.221903400289;1089.2919602258517;1099.8185299425586;1105.165599972024;1119.7424592343725;1128.9435528223555;11542.13433992454;11713.238639488321;11717.765644687144;11723.4138293085;11775.234609750425;3882.6311500407414;4576.313552967082;4699.436067671902;4808.0383923215495;4827.372441582642;9970.850437243447;9979.650712225037;9979.850302245472;10004.949975250223;10010.04904534068;5344.198370244494;5345.599080069011;5347.171188465794;5351.785928562814;5355.437679043722;4404.493483249404;4410.647148228134;4866.294387313819;4904.681195722266;4909.631777616693;3946.210757848442;3950.881473555798;4031.657309128757;4062.410950412174;4074.511058672919;1294.430450601751;1303.4460354349364;1303.7001489657432;1317.6705823544114;1318.953836615714;752.3792870881435;765.058977457719;917.9724608261763;918.8713580098791;919.4621146629297;5665.235193248858;5741.598088133874;5801.811084471061;5929;5930.733117009745;958.4728399380313;993.8111758765812;1000.8748906386702;1017.7353887989176;1030.124394264869;3794.715396345285;3810.7713537187856;3891.727579069438;4007.979960100181;4017.0961533655277;10612.41631710248;10876.836847447295;10883.292585981886;10955.726106847393;10968.780624387467;10880.966308200708;10902.836457453144;10903.890961090447;10906.61826836057;10910.018098371185;8025.31784798287;8096.433249672466;8138.104808471064;8300.958495207486;8312.584370781558;5703.116017017369;5746.994276001599;5851.239338885917;5891.882162356815;5941.732622032106;9822.459764713009;9943.204543636637;9983.750406239902;10175.745606359604;10186.286959912735;8105.311048560939;9988.400695958266;10357.22320825926;10420.166386688896;10444.529996150344;6573.704183311858;6771.356721111487;6775.728970841111;7068.187158476841;7194.2086370498155;6923.93076069253;7925.0489941207425;7999.680012799423;8002.359811215205;8153.55155466455;7354;7513.248675132443;7547.132079810673;7608.2391760823475;7681.116671582839;7332.991492136678;7353.632318384166;7411.925880741123;7441.1070671519765;7512.5492470451945;5839.445252700986;7023.613701246481;7024;7025.859482810213;7027.262137475492;4424.5133035366725;4797.2564252540915;4877.292792545132;4899.11815873132;4982.701037937735;4881.194602890483;4930.433000204879;4998.2002879539095;5039.571636410946;5067.594592432671 16:25:15 INFO - PROCESS | 1648 | |4;prototype.html;255.81964714876014;298.40914988323107;305.8623619371283;309.23155957445755;314.82212549909315;4948.430930443;5097.821576244833;5189.455107213745;5241.885120180659;5249.160134378495;4181.581841815824;4916.360873086503;5003.374578177728;5075.238714192873;5199.102327650408;3557.9186176086955;3658.5426821647293;4013.374583293756;4032.5362583303004;4041.4746083009168;3690.8892733218045;4010.1928649945007;4018.859339923103;4031.0124019615087;4036.777977211252;3045.9695403046017;3483.7387195960277;3866.3427217372973;3932.626400491963;3951.3601855230045;3254.300325430044;3438.3123375324785;3888.655756049795;3904.8871071744416;3929.8035098244973;3414.897553073412;3424.5787997981056;3426.7429942754393;3434.3131373725355;3439.2605589798313;4951.158303088484;5044.571211447032;5070.594352451795;5077.873053173664;5149.476756389379;3607.971728057491;3710.942381421309;4207.747535147871;4500.864974050751;4526.7283962962;4805.351277577517;5048.899022019539;5470.261514695545;5470.699111548864;5500.917486237709;3143.842807859598;3255.788373755722;3543.4684797280356;3745.1760612665444;3776.2825063237897;4720.409948756405;4765.761711914391;5301.072312345363;5670.319561652587;5810.970945145247;3454.547271437257;3506.3162683276514;3788.242351529705;3819.923601527954;3833.4249862520287;3195.3609278144463;3828.8659896904032;3894.4353068804867;3902.5267511914417;3918.138009637932;3975.7614543127506;4334.50153232376;4436.334549817553;4481.910361792811;4484.798184081724;4654.464736555272;5448.727563621803;5517.69652669107;5525.972370138204;5538.723063846792;1042.5725452564411;1226.4235809169677;1227.594404406949;1285.6721536008258;1294.76046931318;867.3148212911855;878.2622597018535;885.4996926736374;886.7295474880094;887.3761017338255;4246.534945443878;4782.856514304576;4858.036597675416;5213.601743198095;5213.661112027706;4871.903821640173;5117.824924407187;5161;5365;5692.8861422771315;4386;4616.168580078527;5126.8974620508125;5146.536811686966;5151.5106064923775;2082.302428686407;2408.4701365699516;2416.5650182966883;2446.584080706284;2465.977898123557;4415.952992435209;4455.643548516111;4581.62551234635;4694.342792009122;5258.579313654898;4892.877678058077;4911.961535962607;5823.475887170175;5883.117402431181;5889.352171261158;5192.818251361185;5439.782408703687;5963.105534169909;5969.970150149222;5985.730642121028;5314.441983591822;5695.373508914099;5774.82675519735;5784.21913041734;5794;5185.403678576861;5658.717064146858;5672.149177623224;5673;5674.404187560247;5646.745896434588;5932.525397968066;5968.075642935018;6031.336552979081;6035.818925432244;3195.392875353675;3743.9625603744703;3759.661630453272;3812.5234345706785;3830.4637350771472;5032.6980381177245;5637.350445290706;5693.032184528723;5699.430056994267;5728.627639203439;5266.07843627356;5527.640703354269;5528.004959107399;5562.527185189304;5606.887862242651;5163.638545301793;5315.893682126259;5538.781468077017;5557.610967232255;5589.664620122806;4843.806247750051;4969.428515720739;5091.66904151229;5312.7343632818975;5433.293671822637;4554.470285528741;4579.839705610288;4965.4041515018425;5190.792368305377;5355.812546560852;4839.60439582409;4977.900441991213;5377.848860455849;5428.402875683592;5456.508914197741 16:25:15 INFO - PROCESS | 1648 | |5;yui.html;720.9062821833161;762.7216066135859;790.9169537198594;805.5851236613141;833.69570106911;14123.223222722747;14505.347259373328;14572.27138643069;14616.415343386265;14725;14667.853321466782;15290.770638440405;15500.302486388111;15748.212589370514;15787.368505259805;853.4282031039203;880.137465284022;880.6345366672823;882.3029806452895;882.9779255518631;690.602903330587;710.350029722803;711.9747563508531;713.985720285594;714.5783987447431;744.0587656614388;882.7307671160294;909.2680392284209;910.4127837544779;916.9174774270315;902.2015516268117;902.7788191893028;902.7923577577128;903.5166186090443;905.343625871238;675.9898601520981;677.14003215916;677.8915373540259;677.949153813466;682.1405029662611;12086.033117350591;12451.190672606343;12466.501339946391;12652.936735316356;12682.682932926658;13200.603981880462;13779.379927903168;13965.79051314231;14267.643308917257;14373.30415098871;11423.320114672706;11584.131190160771;11680.591179308769;11965.40172991347;12077.033837292995;3830.028779987459;3885.164689591723;3898.493195884545;3965.5637879833193;3995.320795464778;81114;83346;83583.16416835814;90523.54738226267;110470;10684.732881678021;10718.464076796128;10725.895972090006;10857.891421085846;10887.292325998786;21281.78718212798;22147.557048858933;22150.667739983914;22169;22171.445713857283;7716.884246736304;7751.651175697107;7824.37405007598;7873.724419645285;7948.880766788503;4250.766207858597;4284.400183974246;4356.586124318184;4372.846950356722;4598.425196850394;3529.3294274087843;3587.3722098633157;3636.5272514573467;3637.690796282293;3643.906827951657;626.4049153304379;649.3279455763262;662.3442791636342;663.2008429842028;668.8361351468824;571.5456212311223;598.7186022569385;617.6942413505344;652.4943169044029;668.2916108924555;9115.225205857576;9547.379420337656;9586.328956972944;9610.27015137282;9635.421874687541;575.3211210771331;631.6494345638123;640.452413186728;666.8299583606149;686.193722376206;4197.538270790211;4602.010567727954;4669.276262179367;4675.976620116878;4687.859364219079;121119;129569;151321;152827;161704;79307;81675;96743;128097.35951320184;131307.343463284;98259.50870245603;101000;102235.4888225569;104336.47831760792;107060;9441.15029647335;10019.649312274036;10071.949640252045;10081;10090.2432317575;55546.9449180299;58749.706251468466;61100;61728.69135654293;62230;60989;76375.61812190904;89154.55422722845;92313.53843230741;94586.52706736422;11227.7754444909;12389.876101239233;12823.358832058546;13175.868241317847;13565.02298099129;14480.782788258395;14610.415583376545;14665.753410960187;14707.705845883236;14732;13290;13390;13400.06199566021;13482.595522134352;14201.502947396792;13270.734585308433;13561;13881.791773123614;14045.438182472586;14311;11589.536418543501;12380.394066154711;12696.936515317733;13699.315034248448;13946.372413241226;10338.793224135325;10658.62694805678;11420.657380278604;11487.54049837997;11492.080633549464;10641.414722190353;10783.921607839153;11220.382878941737;11484;11710 16:25:15 INFO - PROCESS | 1648 | __end_tp_report 16:25:15 INFO - PROCESS | 1648 | __start_cc_report 16:25:15 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1208 16:25:15 INFO - PROCESS | 1648 | __end_cc_report 16:25:15 INFO - PROCESS | 1648 | __startTimestamp1476919515308__endTimestamp 16:25:15 INFO - PROCESS | 1648 | 16:25:15 INFO - PROCESS | 1648 | ------- Summary: start ------- 16:25:15 INFO - PROCESS | 1648 | Number of tests: 6 16:25:15 INFO - PROCESS | 1648 | 16:25:15 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5549.82 Median:5727.51 stddev:624.50 (10.9%) stddev-sans-first:587.95 16:25:15 INFO - PROCESS | 1648 | Values: 2798.9 3225.8 3236.3 3247.3 3286.3 5430.8 5474.3 5507.5 5521.2 5534.6 5454.4 5511.8 5515.7 5517.1 5541.9 5005.5 5017.3 5045.5 5112.5 5136.6 4954.4 5026.6 5032.9 5050.8 5146.9 5141.6 5147.2 5156.9 5157.2 5175.0 5140.9 5144.0 5147.3 5152.2 5195.9 4960.9 4962.3 5080.6 5109.9 5111.8 5377.4 5496.7 5498.5 5515.0 5517.4 5890.6 5900.8 5912.6 5951.9 6007.9 6050.2 6081.1 6081.2 6083.0 6095.1 5394.5 5507.8 5521.6 5523.2 5575.9 5097.2 6125.0 6193.3 6214.5 6234.7 5727.5 5878.2 5896.3 5901.9 5907.0 5876.3 5941.8 5976.0 6026.0 6031.2 5876.7 5919.3 5927.7 5943.5 5948.9 5930.2 5996.6 6015.7 6035.6 6060.8 4782.1 4829.7 4831.8 4838.2 4854.2 4238.0 4272.7 4286.9 4340.7 4350.5 5558.0 5609.5 5629.9 5664.7 5696.4 6097.4 6105.2 6105.5 6109.9 6124.7 5411.0 5612.3 5637.9 5654.9 5660.3 4441.8 5137.9 5151.6 5202.8 5220.2 6184.9 6187.8 6195.2 6204.0 6215.4 6006.4 6013.1 6017.5 6030.0 6089.0 6004.8 6132.3 6136.3 6137.0 6190.0 5909.1 5969.7 5977.8 5998.8 6010.5 6030.9 6067.3 6070.6 6083.1 6097.4 5526.8 5760.7 5828.9 5868.9 5889.1 5769.9 5770.1 5836.6 5873.4 5910.9 5717.4 5747.4 5768.4 5772.5 5779.7 5663.5 5838.1 5841.7 5855.3 5868.2 5662.0 5685.5 5725.3 5750.6 5813.1 16:25:15 INFO - PROCESS | 1648 | 16:25:15 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:76916.39 Median:40911.99 stddev:168586.32 (412.1%) stddev-sans-first:168961.56 16:25:15 INFO - PROCESS | 1648 | Values: 477.7 478.9 497.3 525.4 534.9 31477.5 41968.8 42943.0 43029.8 45573.0 44305.0 44496.6 44547.6 44663.3 44720.8 9788.4 9968.2 9985.0 9985.4 9987.9 8802.4 9024.1 12036.5 12288.0 12351.0 12261.9 12332.3 12356.8 12357.9 12386.8 12269.3 12336.1 12341.8 12351.8 12352.5 12109.6 12201.8 12206.8 12215.7 12227.4 41564.8 41788.4 41789.4 41808.0 41859.8 3456.3 3547.6 3952.4 3985.5 4014.3 29323.6 30076.2 30104.4 31299.4 32132.5 3145.6 3181.6 3273.9 3314.8 3322.7 523910.0 531544.0 532654.0 532657.0 533147.0 63931.0 64043.7 64257.4 64310.0 64313.0 67796.0 67818.0 67820.0 67859.7 67983.3 17050.7 17238.3 17265.2 17271.6 17312.4 9887.9 12145.2 13135.9 13239.1 13268.2 16119.5 16207.8 16227.6 16253.6 16261.1 6420.6 7032.3 7351.9 8465.5 8718.7 834.5 904.8 915.7 918.8 998.2 29436.1 29459.0 29492.7 30352.6 30441.5 974.9 1051.8 1069.0 1083.4 1133.5 15340.0 15493.0 15780.8 15903.8 16202.6 627447.0 679585.0 698144.0 699000.0 703717.0 59970.7 60441.4 60476.1 60480.7 60608.0 1237.6 1270.7 1353.0 1374.2 1391.3 26530.1 29513.9 31664.8 32365.5 32987.7 58245.0 59090.4 62912.0 62968.0 63208.7 658775.0 668045.0 669284.0 669861.0 672517.0 38392.8 43718.1 45910.3 46252.8 48394.8 48863.8 49461.0 49833.0 49994.5 50202.0 39429.8 40703.6 41515.4 41954.4 42206.4 40619.0 40684.6 40909.4 41661.3 42334.8 39301.2 40143.8 40656.0 40914.6 42062.9 32013.0 35881.0 36452.5 36827.8 36875.0 26130.9 26171.6 26365.5 26461.0 26777.6 16:25:15 INFO - PROCESS | 1648 | 16:25:15 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:34500.42 Median:419.04 stddev:104615.79 (24965.6%) stddev-sans-first:104877.85 16:25:15 INFO - PROCESS | 1648 | Values: 359.0 370.9 376.4 385.6 404.3 15423.9 15562.3 17786.9 20649.9 20966.6 19573.2 19664.0 20271.4 20319.3 20619.5 5115.0 5854.8 6000.4 6121.6 6132.1 6809.6 6862.7 6877.8 6896.8 6936.0 6550.0 6813.9 6828.1 6836.0 6871.5 5778.8 6744.1 6772.8 6782.6 6783.5 5850.8 5987.5 5989.0 5995.0 6003.4 10739.7 12783.0 12858.9 13019.4 13149.3 2064.6 2209.3 2319.5 2567.6 2654.7 9499.0 9816.2 10267.4 10312.8 10342.3 1818.8 1840.3 1840.6 1877.0 1880.3 83810.0 86866.1 91495.0 119607.4 119794.4 10588.9 11376.3 11610.4 11723.4 11727.8 14330.9 14573.7 14581.6 14602.5 14613.8 6288.8 6576.8 6607.1 8049.2 8524.4 8555.5 8560.6 8672.0 8676.7 8726.8 4392.3 4458.7 4484.6 4504.8 4554.7 1693.4 1895.4 1913.9 1927.6 1949.4 693.7 826.3 972.0 999.1 1024.9 11255.3 11316.3 11511.4 11831.0 11833.6 382.2 428.7 431.4 436.0 444.5 5855.4 5984.6 9726.7 11374.0 11513.8 553424.0 631776.0 644563.0 647974.0 660209.0 90618.4 133842.2 137395.0 138965.0 142419.0 409.4 445.5 445.7 446.5 446.5 9140.5 11093.5 11186.3 11773.5 11792.9 55275.7 55714.0 56154.7 56837.0 57274.8 75936.1 77845.8 78656.0 78980.0 79769.2 7976.9 8155.4 8376.9 8482.5 8508.7 11199.4 12631.5 12632.6 13058.7 13078.1 11004.8 11053.1 11360.9 11374.3 11599.5 10251.2 10433.2 11094.7 11135.3 11207.8 9469.0 11188.0 11328.7 11413.3 11450.9 7094.4 7921.9 7973.8 8295.7 8546.6 8148.3 10265.1 11055.3 11133.3 11423.3 16:25:15 INFO - PROCESS | 1648 | 16:25:15 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5677.57 Median:4871.79 stddev:3193.84 (65.6%) stddev-sans-first:3186.67 16:25:15 INFO - PROCESS | 1648 | Values: 1406.4 1508.0 1677.9 1709.8 1844.5 7992.9 9022.8 9041.6 9050.0 9052.0 7833.0 8027.5 8033.5 8581.4 8805.3 2336.8 2385.7 2388.8 2390.4 2393.2 2393.0 2407.9 2414.0 2424.8 2426.4 2195.6 2261.4 2377.7 2401.7 2408.0 2362.0 2364.3 2376.9 2379.8 2382.9 2121.0 2272.1 2324.6 2377.7 2378.9 8904.2 8932.1 8954.0 8961.1 8973.5 4382.9 5356.8 5370.5 5372.5 5373.8 3498.2 3567.1 3696.8 3699.2 3705.2 1089.3 1099.8 1105.2 1119.7 1128.9 11542.1 11713.2 11717.8 11723.4 11775.2 3882.6 4576.3 4699.4 4808.0 4827.4 9970.9 9979.7 9979.9 10004.9 10010.0 5344.2 5345.6 5347.2 5351.8 5355.4 4404.5 4410.6 4866.3 4904.7 4909.6 3946.2 3950.9 4031.7 4062.4 4074.5 1294.4 1303.4 1303.7 1317.7 1319.0 752.4 765.1 918.0 918.9 919.5 5665.2 5741.6 5801.8 5929.0 5930.7 958.5 993.8 1000.9 1017.7 1030.1 3794.7 3810.8 3891.7 4008.0 4017.1 10612.4 10876.8 10883.3 10955.7 10968.8 10881.0 10902.8 10903.9 10906.6 10910.0 8025.3 8096.4 8138.1 8301.0 8312.6 5703.1 5747.0 5851.2 5891.9 5941.7 9822.5 9943.2 9983.8 10175.7 10186.3 8105.3 9988.4 10357.2 10420.2 10444.5 6573.7 6771.4 6775.7 7068.2 7194.2 6923.9 7925.0 7999.7 8002.4 8153.6 7354.0 7513.2 7547.1 7608.2 7681.1 7333.0 7353.6 7411.9 7441.1 7512.5 5839.4 7023.6 7024.0 7025.9 7027.3 4424.5 4797.3 4877.3 4899.1 4982.7 4881.2 4930.4 4998.2 5039.6 5067.6 16:25:15 INFO - PROCESS | 1648 | 16:25:15 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4364.17 Median:4914.16 stddev:1386.63 (28.2%) stddev-sans-first:1355.80 16:25:15 INFO - PROCESS | 1648 | Values: 255.8 298.4 305.9 309.2 314.8 4948.4 5097.8 5189.5 5241.9 5249.2 4181.6 4916.4 5003.4 5075.2 5199.1 3557.9 3658.5 4013.4 4032.5 4041.5 3690.9 4010.2 4018.9 4031.0 4036.8 3046.0 3483.7 3866.3 3932.6 3951.4 3254.3 3438.3 3888.7 3904.9 3929.8 3414.9 3424.6 3426.7 3434.3 3439.3 4951.2 5044.6 5070.6 5077.9 5149.5 3608.0 3710.9 4207.7 4500.9 4526.7 4805.4 5048.9 5470.3 5470.7 5500.9 3143.8 3255.8 3543.5 3745.2 3776.3 4720.4 4765.8 5301.1 5670.3 5811.0 3454.5 3506.3 3788.2 3819.9 3833.4 3195.4 3828.9 3894.4 3902.5 3918.1 3975.8 4334.5 4436.3 4481.9 4484.8 4654.5 5448.7 5517.7 5526.0 5538.7 1042.6 1226.4 1227.6 1285.7 1294.8 867.3 878.3 885.5 886.7 887.4 4246.5 4782.9 4858.0 5213.6 5213.7 4871.9 5117.8 5161.0 5365.0 5692.9 4386.0 4616.2 5126.9 5146.5 5151.5 2082.3 2408.5 2416.6 2446.6 2466.0 4416.0 4455.6 4581.6 4694.3 5258.6 4892.9 4912.0 5823.5 5883.1 5889.4 5192.8 5439.8 5963.1 5970.0 5985.7 5314.4 5695.4 5774.8 5784.2 5794.0 5185.4 5658.7 5672.1 5673.0 5674.4 5646.7 5932.5 5968.1 6031.3 6035.8 3195.4 3744.0 3759.7 3812.5 3830.5 5032.7 5637.4 5693.0 5699.4 5728.6 5266.1 5527.6 5528.0 5562.5 5606.9 5163.6 5315.9 5538.8 5557.6 5589.7 4843.8 4969.4 5091.7 5312.7 5433.3 4554.5 4579.8 4965.4 5190.8 5355.8 4839.6 4977.9 5377.8 5428.4 5456.5 16:25:15 INFO - PROCESS | 1648 | 16:25:15 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:22852.38 Median:3736.97 stddev:35644.78 (953.8%) stddev-sans-first:35706.04 16:25:15 INFO - PROCESS | 1648 | Values: 720.9 762.7 790.9 805.6 833.7 14123.2 14505.3 14572.3 14616.4 14725.0 14667.9 15290.8 15500.3 15748.2 15787.4 853.4 880.1 880.6 882.3 883.0 690.6 710.4 712.0 714.0 714.6 744.1 882.7 909.3 910.4 916.9 902.2 902.8 902.8 903.5 905.3 676.0 677.1 677.9 677.9 682.1 12086.0 12451.2 12466.5 12652.9 12682.7 13200.6 13779.4 13965.8 14267.6 14373.3 11423.3 11584.1 11680.6 11965.4 12077.0 3830.0 3885.2 3898.5 3965.6 3995.3 81114.0 83346.0 83583.2 90523.5 110470.0 10684.7 10718.5 10725.9 10857.9 10887.3 21281.8 22147.6 22150.7 22169.0 22171.4 7716.9 7751.7 7824.4 7873.7 7948.9 4250.8 4284.4 4356.6 4372.8 4598.4 3529.3 3587.4 3636.5 3637.7 3643.9 626.4 649.3 662.3 663.2 668.8 571.5 598.7 617.7 652.5 668.3 9115.2 9547.4 9586.3 9610.3 9635.4 575.3 631.6 640.5 666.8 686.2 4197.5 4602.0 4669.3 4676.0 4687.9 121119.0 129569.0 151321.0 152827.0 161704.0 79307.0 81675.0 96743.0 128097.4 131307.3 98259.5 101000.0 102235.5 104336.5 107060.0 9441.2 10019.6 10071.9 10081.0 10090.2 55546.9 58749.7 61100.0 61728.7 62230.0 60989.0 76375.6 89154.6 92313.5 94586.5 11227.8 12389.9 12823.4 13175.9 13565.0 14480.8 14610.4 14665.8 14707.7 14732.0 13290.0 13390.0 13400.1 13482.6 14201.5 13270.7 13561.0 13881.8 14045.4 14311.0 11589.5 12380.4 12696.9 13699.3 13946.4 10338.8 10658.6 11420.7 11487.5 11492.1 10641.4 10783.9 11220.4 11484.0 11710.0 16:25:15 INFO - PROCESS | 1648 | -------- Summary: end -------- 16:25:15 INFO - PROCESS | 1648 | 16:25:15 INFO - TEST-INFO | 1648: exit 0 16:25:15 INFO - TEST-OK | dromaeo_css | took 1115979ms 16:25:15 INFO - TEST-START | kraken 16:25:15 INFO - operating with platform_type : mac_ 16:25:15 INFO - Initialising browser for kraken test... 16:25:15 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpuqekhH/profile http://localhost:49271/getInfo.html) 16:25:18 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 16:25:18 INFO - PROCESS | 1657 | colorDepth:24 16:25:18 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 16:25:18 INFO - PROCESS | 1657 | __metrics 16:25:18 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:25:18 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:25:19 INFO - TEST-INFO | 1657: exit 0 16:25:19 INFO - Browser initialized. 16:25:19 INFO - Running cycle 1/1 for kraken test... 16:25:19 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpuqekhH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:31 INFO - PROCESS | 1658 | RSS: Main: 219860992 16:25:31 INFO - PROCESS | 1658 | 16:25:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 16:25:34 INFO - PROCESS | 1658 | RSS: Main: 269795328 16:25:34 INFO - PROCESS | 1658 | 16:25:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 16:25:38 INFO - PROCESS | 1658 | RSS: Main: 282030080 16:25:38 INFO - PROCESS | 1658 | 16:25:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 16:25:41 INFO - PROCESS | 1658 | RSS: Main: 379240448 16:25:41 INFO - PROCESS | 1658 | 16:25:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 16:25:44 INFO - PROCESS | 1658 | RSS: Main: 280215552 16:25:44 INFO - PROCESS | 1658 | 16:25:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:25:47 INFO - PROCESS | 1658 | RSS: Main: 282361856 16:25:47 INFO - PROCESS | 1658 | 16:25:49 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 16:25:50 INFO - PROCESS | 1658 | RSS: Main: 319238144 16:25:50 INFO - PROCESS | 1658 | 16:25:53 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 16:25:54 INFO - PROCESS | 1658 | RSS: Main: 319496192 16:25:54 INFO - PROCESS | 1658 | 16:25:56 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 16:25:57 INFO - PROCESS | 1658 | RSS: Main: 318574592 16:25:57 INFO - PROCESS | 1658 | 16:25:59 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:25:59 INFO - PROCESS | 1658 | RSS: Main: 290316288 16:25:59 INFO - PROCESS | 1658 | 16:26:01 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:26:02 INFO - PROCESS | 1658 | RSS: Main: 295211008 16:26:02 INFO - PROCESS | 1658 | 16:26:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:26:05 INFO - PROCESS | 1658 | RSS: Main: 298369024 16:26:05 INFO - PROCESS | 1658 | 16:26:08 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:26:08 INFO - PROCESS | 1658 | RSS: Main: 315199488 16:26:08 INFO - PROCESS | 1658 | 16:26:11 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:26:12 INFO - PROCESS | 1658 | RSS: Main: 308936704 16:26:12 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 16:26:14 INFO - PROCESS | 1658 | RSS: Main: 352673792 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | __start_tp_report 16:26:14 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 16:26:14 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 16:26:14 INFO - PROCESS | 1658 | |i|pagename|runs| 16:26:14 INFO - PROCESS | 1658 | |0;ai-astar;115;114;115;111;115;114;113;113;112;111 16:26:14 INFO - PROCESS | 1658 | |1;audio-beat-detection;143;108;109;142;128;144;109;108;142;106 16:26:14 INFO - PROCESS | 1658 | |2;audio-dft;183;185;185;185;184;182;184;184;184;183 16:26:14 INFO - PROCESS | 1658 | |3;audio-fft;80;60;58;87;64;77;81;80;109;57 16:26:14 INFO - PROCESS | 1658 | |4;audio-oscillator;88;70;95;68;68;68;92;69;80;120 16:26:14 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;87;84;88;84;87;83;87;84;100;84 16:26:14 INFO - PROCESS | 1658 | |6;imaging-darkroom;95;95;94;95;96;94;94;117;159;95 16:26:14 INFO - PROCESS | 1658 | |7;imaging-desaturate;83;87;84;86;83;84;83;86;84;86 16:26:14 INFO - PROCESS | 1658 | |8;json-parse-financial;59;55;56;55;56;59;58;58;57;57 16:26:14 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;71;70;66;75;71;70;69;71;71;71 16:26:14 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;81;87;88;100;77;83;95;103;102;100 16:26:14 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;137;137;137;150;150;146;149;155;168;137 16:26:14 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;164;165;165;164;171;163;162;162;165;163 16:26:14 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;68;65;71;86;85;75;66;66;66;66 16:26:14 INFO - PROCESS | 1658 | __end_tp_report 16:26:14 INFO - PROCESS | 1658 | __start_cc_report 16:26:14 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1967 16:26:14 INFO - PROCESS | 1658 | __end_cc_report 16:26:14 INFO - PROCESS | 1658 | __startTimestamp1476919574310__endTimestamp 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | ------- Summary: start ------- 16:26:14 INFO - PROCESS | 1658 | Number of tests: 14 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:1.57 (1.4%) stddev-sans-first:1.54 16:26:14 INFO - PROCESS | 1658 | Values: 115.0 114.0 115.0 111.0 115.0 114.0 113.0 113.0 112.0 111.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:135.00 stddev:17.36 (12.9%) stddev-sans-first:16.98 16:26:14 INFO - PROCESS | 1658 | Values: 143.0 108.0 109.0 142.0 128.0 144.0 109.0 108.0 142.0 106.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:0.99 (0.5%) stddev-sans-first:1.00 16:26:14 INFO - PROCESS | 1658 | Values: 183.0 185.0 185.0 185.0 184.0 182.0 184.0 184.0 184.0 183.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:75.30 Median:78.50 stddev:16.15 (20.6%) stddev-sans-first:17.04 16:26:14 INFO - PROCESS | 1658 | Values: 80.0 60.0 58.0 87.0 64.0 77.0 81.0 80.0 109.0 57.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:75.00 stddev:17.17 (22.9%) stddev-sans-first:18.07 16:26:14 INFO - PROCESS | 1658 | Values: 88.0 70.0 95.0 68.0 68.0 68.0 92.0 69.0 80.0 120.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:85.50 stddev:4.96 (5.8%) stddev-sans-first:5.26 16:26:14 INFO - PROCESS | 1658 | Values: 87.0 84.0 88.0 84.0 87.0 83.0 87.0 84.0 100.0 84.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:95.00 stddev:20.76 (21.9%) stddev-sans-first:21.79 16:26:14 INFO - PROCESS | 1658 | Values: 95.0 95.0 94.0 95.0 96.0 94.0 94.0 117.0 159.0 95.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.51 (1.8%) stddev-sans-first:1.48 16:26:14 INFO - PROCESS | 1658 | Values: 83.0 87.0 84.0 86.0 83.0 84.0 83.0 86.0 84.0 86.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.50 stddev:1.49 (2.6%) stddev-sans-first:1.39 16:26:14 INFO - PROCESS | 1658 | Values: 59.0 55.0 56.0 55.0 56.0 59.0 58.0 58.0 57.0 57.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.00 stddev:2.22 (3.1%) stddev-sans-first:2.35 16:26:14 INFO - PROCESS | 1658 | Values: 71.0 70.0 66.0 75.0 71.0 70.0 69.0 71.0 71.0 71.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:82.00 stddev:9.57 (11.7%) stddev-sans-first:9.35 16:26:14 INFO - PROCESS | 1658 | Values: 81.0 87.0 88.0 100.0 77.0 83.0 95.0 103.0 102.0 100.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:149.50 stddev:10.15 (6.8%) stddev-sans-first:10.15 16:26:14 INFO - PROCESS | 1658 | Values: 137.0 137.0 137.0 150.0 150.0 146.0 149.0 155.0 168.0 137.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:164.50 stddev:2.59 (1.6%) stddev-sans-first:2.74 16:26:14 INFO - PROCESS | 1658 | Values: 164.0 165.0 165.0 164.0 171.0 163.0 162.0 162.0 165.0 163.0 16:26:14 INFO - PROCESS | 1658 | 16:26:14 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:69.50 stddev:8.03 (11.6%) stddev-sans-first:8.42 16:26:14 INFO - PROCESS | 1658 | Values: 68.0 65.0 71.0 86.0 85.0 75.0 66.0 66.0 66.0 66.0 16:26:14 INFO - PROCESS | 1658 | -------- Summary: end -------- 16:26:14 INFO - PROCESS | 1658 | 16:26:15 INFO - TEST-INFO | 1658: exit 0 16:26:15 INFO - TEST-OK | kraken | took 59305ms 16:26:15 INFO - SUITE-END | took 1175s 16:26:15 INFO - Completed test suite (00:19:35) 16:26:15 INFO - javascript benchmark 16:26:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2798.9020384286546, 3225.8064516129025, 3236.3365510070425, 3247.2693643930133, 3286.326303107863, 5430.782768689252, 5474.288342515468, 5507.531859791918, 5521.2270282160525, 5534.584906132036, 5454.400015998237, 5511.834644960658, 5515.7242137893145, 5517.144842549411, 5541.861453463665, 5005.524475174861, 5017.322661440713, 5045.4702256262935, 5112.488751124895, 5136.64043516954, 4954.43024052235, 5026.623003274751, 5032.899342013157, 5050.823221187259, 5146.922796158061, 5141.614378921578, 5147.202183661539, 5156.896862062757, 5157.200633901752, 5174.990876779029, 5140.8714782130555, 5143.974280128576, 5147.330846989905, 5152.175651895697, 5195.870103247411, 4960.925586116211, 4962.255661650745, 5080.644354895159, 5109.923351149736, 5111.8466446006305, 5377.435369286247, 5496.725163741837, 5498.45015498451, 5514.972425137848, 5517.36550296717, 5890.646561206298, 5900.793472228452, 5912.615679980788, 5951.9107213391835, 6007.909881351783, 6050.2437195350585, 6081.11823785553, 6081.209442772455, 6083.0, 6095.146679464879, 5394.514493695547, 5507.834764957058, 5521.641093328921, 5523.171524271392, 5575.8884822303735, 5097.235414687826, 6125.021800333839, 6193.318734939153, 6214.533909956771, 6234.719437625317, 5727.513161381329, 5878.177055212273, 5896.292444906639, 5901.881962360729, 5906.970465147647, 5876.324222714357, 5941.792037278675, 5976.0, 6026.0, 6031.2159419276095, 5876.676782776988, 5919.289685237713, 5927.673977931255, 5943.524518038546, 5948.881022379528, 5930.199423077829, 5996.640201587918, 6015.729292181863, 6035.637861728311, 6060.787872424532, 4782.056074766355, 4829.710217386968, 4831.782569784298, 4838.153323168432, 4854.247591623304, 4237.978810105929, 4272.700910936204, 4286.914261714811, 4340.674449416307, 4350.456192975878, 5557.9995600792245, 5609.495145436848, 5629.943700563023, 5664.688442135722, 5696.3733989261145, 6097.359777223416, 6105.206323177958, 6105.511559075263, 6109.877802443926, 6124.693765311717, 5411.0, 5612.326520817528, 5637.887242255132, 5654.943450565524, 5660.29246344207, 4441.800118994653, 5137.8715532112, 5151.562117220078, 5202.76587553561, 5220.216967454912, 6184.907226391608, 6187.783427580013, 6195.19462469876, 6204.007358822567, 6215.378462153839, 6006.399360063959, 6013.06797446379, 6017.518598512021, 6029.969850150721, 6088.969555152196, 6004.789832355847, 6132.324915438686, 6136.274005701014, 6137.039921714347, 6190.0, 5909.08409196558, 5969.701514924323, 5977.820665380045, 5998.760049597967, 6010.519158467399, 6030.90953635687, 6067.302260240129, 6070.575059745952, 6083.117947897618, 6097.420745029215, 5526.834194974157, 5760.740766665426, 5828.94171058301, 5868.911966320594, 5889.087191485327, 5769.884602308014, 5770.13447982806, 5836.649801011953, 5873.4126587340925, 5910.940890591039, 5717.37108918027, 5747.367789543064, 5768.365479797303, 5772.538196944319, 5779.682117483579, 5663.490285874291, 5838.12428135783, 5841.737121829443, 5855.268091488564, 5868.2077919482035, 5661.971690141688, 5685.459881311269, 5725.341585717696, 5750.597458177887, 5813.069908814569], "value": 5508.7691909143305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.6966626192368, 478.868311214416, 497.2764627467036, 525.4062908912928, 534.9277847490588, 31477.527837082434, 41968.79015604922, 42942.99999999996, 43029.7848510757, 45573.0, 44305.0, 44496.555034449644, 44547.55452445475, 44663.33005004928, 44720.77639611797, 9788.41269523829, 9968.202543796478, 9984.950075249613, 9985.40087594743, 9987.900120998806, 8802.427842190236, 9024.097590240955, 12036.518539258463, 12288.0, 12351.0, 12261.93869030658, 12332.321722305269, 12356.814647780291, 12357.876421235807, 12386.752264954695, 12269.325187114706, 12336.074794390366, 12341.75316493665, 12351.814722779165, 12352.505899763999, 12109.576164834189, 12201.816972745415, 12206.816897746541, 12215.694607634792, 12227.449764760608, 41564.79217603893, 41788.37317440241, 41789.37315940263, 41808.0, 41859.79070104661, 3456.343294773985, 3547.609762926076, 3952.446657467957, 3985.4818873546255, 4014.297497937849, 29323.560146597818, 30076.24809379761, 30104.397912041855, 31299.374012519624, 32132.518012229837, 3145.6067991501063, 3181.602299712536, 3273.918152046194, 3314.8342582871, 3322.7175690066374, 523909.9999999962, 531544.0, 532654.0, 532657.0, 533147.0, 63931.0, 64043.6797816008, 64257.357426426075, 64310.0, 64313.03530447047, 67796.0, 67818.0, 67820.0, 67859.66070169618, 67983.32016679869, 17050.74423883643, 17238.310467581407, 17265.223064962105, 17271.56821079458, 17312.394066207624, 9887.851682224773, 12145.210561313486, 13135.934320328528, 13239.139455935527, 13268.203907765565, 16119.516414507583, 16207.837921620632, 16227.594310142105, 16253.593660158354, 16261.105639189958, 6420.6468644225015, 7032.331928466788, 7351.8604616284565, 8465.534395608178, 8718.694845680371, 834.4576025583419, 904.8009437923646, 915.7252824152728, 918.7794929217074, 998.2014388489325, 29436.116916492538, 29459.0, 29492.705072949426, 30352.634131464136, 30441.543376849364, 974.8732664753678, 1051.7686109055996, 1068.9679309620724, 1083.3608171179042, 1133.5352505472881, 15340.0, 15493.0, 15780.763288550681, 15903.840961590467, 16202.594935126715, 627447.0, 679585.0, 698144.0, 699000.0, 703717.0, 59970.70014649986, 60441.395586043574, 60476.09285860715, 60480.69759651174, 60608.0, 1237.6348977051791, 1270.733146039342, 1352.959411217665, 1374.2304309586664, 1391.325207274471, 26530.071447499246, 29513.85243073771, 31664.841675791475, 32365.51451728273, 32987.67012329846, 58245.0, 59090.40909591021, 62912.0, 62968.0, 63208.683956579924, 658775.0, 668045.0, 669284.0, 669861.0, 672517.0, 38392.80803595964, 43718.125637487705, 45910.31134532918, 46252.768736156104, 48394.75802621105, 48863.755681221366, 49461.01077978492, 49833.0, 49994.50005500044, 50201.99596008132, 39429.802850985565, 40703.59296406998, 41515.37726934159, 41954.37068444037, 42206.366904497074, 40618.9845253871, 40684.59315406808, 40909.38635920523, 41661.33354665779, 42334.7883260594, 39301.21397571975, 40143.799281003405, 40655.983600410225, 40914.590854091075, 42062.948426289586, 32013.0, 35881.0, 36452.45321320235, 36827.81586092053, 36875.0, 26130.86934565315, 26171.607425889008, 26365.472690546467, 26461.0, 26777.598336025363], "value": 21403.04085687613, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.9874354397597, 370.8998570385995, 376.4485029431884, 385.63172170577104, 404.2743275819903, 15423.922880385597, 15562.299696513655, 17786.91106544467, 20649.896750516265, 20966.580668386625, 19573.21707131713, 19664.0, 20271.39185824424, 20319.288824891093, 20619.484512887186, 5115.0, 5854.795082172135, 6000.429959153874, 6121.571489995702, 6132.110843927628, 6809.557378770364, 6862.691178896936, 6877.7592784252565, 6896.827579310508, 6936.028955946172, 6549.967250163742, 6813.863722725542, 6828.146481689789, 6835.965820170893, 6871.450283977295, 5778.7688492460675, 6744.055832183473, 6772.8306792330095, 6782.626955517445, 6783.457323414115, 5850.76596936122, 5987.461128498456, 5988.970055149696, 5994.970025149846, 6003.399660034005, 10739.731506712316, 12783.0, 12858.906992905615, 13019.414126364336, 13149.342532873317, 2064.5870825834895, 2209.3151123151715, 2319.5476882008015, 2567.5763499022637, 2654.6814382274056, 9498.9525052375, 9816.214702823758, 10267.43529105899, 10312.845307320396, 10342.276040677156, 1818.809025052377, 1840.2638944422204, 1840.5858681796622, 1876.990615046916, 1880.304287413652, 83809.99999999939, 86866.13133868643, 91495.0, 119607.4019629905, 119794.40102799518, 10588.894111058791, 11376.260543064674, 11610.419479026015, 11723.41382930867, 11727.824082638766, 14330.928345358416, 14573.708525829425, 14581.562553123424, 14602.488912887999, 14613.78079328811, 6288.811335659938, 6576.835579110465, 6607.108040414579, 8049.235322644339, 8524.36067294943, 8555.486670799772, 8560.61477233526, 8671.956640216884, 8676.739697809076, 8726.781830454163, 4392.253316936129, 4458.687891847604, 4484.551544845489, 4504.754358161622, 4554.681172317973, 1693.3903794633923, 1895.3555791031115, 1913.9330123445613, 1927.6461640934904, 1949.3859434278156, 693.6566399632113, 826.3306721555559, 971.9902800972042, 999.0908273471251, 1024.8843910602402, 11255.324680519196, 11316.26444281119, 11511.366874821964, 11831.0, 11833.585824496102, 382.22599236546216, 428.661357527556, 431.40250752707726, 436.00373147358135, 444.51103785835966, 5855.443732845373, 5984.551158663117, 9726.70819875405, 11374.014528522375, 11513.827292590451, 553424.0, 631776.0, 644563.0, 647974.0, 660209.0, 90618.4041818725, 133842.17050543928, 137395.0, 138965.0, 142419.0, 409.4186255517173, 445.465441470237, 445.692472194185, 446.5155306492427, 446.5266817173806, 9140.542972851197, 11093.500792464198, 11186.32882027081, 11773.529058837894, 11792.941035294769, 55275.723621381636, 55714.0, 56154.719226403606, 56837.0, 57274.78307647875, 75936.11622468692, 77845.83231251649, 78656.0, 78980.0, 79769.20230797617, 7976.9202307976175, 8155.429119961545, 8376.874346884924, 8482.533460659723, 8508.74473765788, 11199.384033878216, 12631.494740210288, 12632.557860474839, 13058.673533161747, 13078.084534082524, 11004.779904402027, 11053.11575073976, 11360.943195283971, 11374.31754094757, 11599.536018559163, 10251.231157663056, 10433.217508686726, 11094.722631934266, 11135.33188008722, 11207.831882521605, 9469.0, 11188.04901583342, 11328.716782080184, 11413.258138220988, 11450.94274528622, 7094.432445404458, 7921.9207807923485, 7973.760787176394, 8295.668173273243, 8546.615402306787, 8148.266656000988, 10265.12746416533, 11055.336679799238, 11133.276337038067, 11423.257488263569], "value": 8655.705012718365, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.3671347893448, 1507.9999999999995, 1677.9496615101543, 1709.8373106287736, 1844.4835446075094, 7992.880106798395, 9022.819543609132, 9041.638334466621, 9049.95475022624, 9051.954740226289, 7833.0, 8027.478213916092, 8033.517988920669, 8581.442206256588, 8805.25155361795, 2336.7546407627165, 2385.7256415512265, 2388.8088952883727, 2390.426297688551, 2393.2222027840935, 2393.0, 2407.9398015049587, 2414.022320960014, 2424.793892519138, 2426.38127277544, 2195.6047911375945, 2261.3555136786017, 2377.6552399902002, 2401.651760494727, 2408.0247499762536, 2361.9645705314433, 2364.3498038039506, 2376.893039813195, 2379.7501262367464, 2382.8808559572126, 2121.0349291072525, 2272.1138755885218, 2324.569954558412, 2377.738448770634, 2378.9167379141645, 8904.243139333164, 8932.10678932108, 8954.0, 8961.148690874421, 8973.506457144855, 4382.9342559861625, 5356.758945847446, 5370.516653501204, 5372.489613486712, 5373.811916582901, 3498.177928186874, 3567.0547304964207, 3696.7597106188014, 3699.186179040607, 3705.221903400289, 1089.2919602258517, 1099.8185299425586, 1105.165599972024, 1119.7424592343725, 1128.9435528223555, 11542.13433992454, 11713.238639488321, 11717.765644687144, 11723.4138293085, 11775.234609750425, 3882.6311500407414, 4576.313552967082, 4699.436067671902, 4808.0383923215495, 4827.372441582642, 9970.850437243447, 9979.650712225037, 9979.850302245472, 10004.949975250223, 10010.04904534068, 5344.198370244494, 5345.599080069011, 5347.171188465794, 5351.785928562814, 5355.437679043722, 4404.493483249404, 4410.647148228134, 4866.294387313819, 4904.681195722266, 4909.631777616693, 3946.210757848442, 3950.881473555798, 4031.657309128757, 4062.410950412174, 4074.511058672919, 1294.430450601751, 1303.4460354349364, 1303.7001489657432, 1317.6705823544114, 1318.953836615714, 752.3792870881435, 765.058977457719, 917.9724608261763, 918.8713580098791, 919.4621146629297, 5665.235193248858, 5741.598088133874, 5801.811084471061, 5929.0, 5930.733117009745, 958.4728399380313, 993.8111758765812, 1000.8748906386702, 1017.7353887989176, 1030.124394264869, 3794.715396345285, 3810.7713537187856, 3891.727579069438, 4007.979960100181, 4017.0961533655277, 10612.41631710248, 10876.836847447295, 10883.292585981886, 10955.726106847393, 10968.780624387467, 10880.966308200708, 10902.836457453144, 10903.890961090447, 10906.61826836057, 10910.018098371185, 8025.31784798287, 8096.433249672466, 8138.104808471064, 8300.958495207486, 8312.584370781558, 5703.116017017369, 5746.994276001599, 5851.239338885917, 5891.882162356815, 5941.732622032106, 9822.459764713009, 9943.204543636637, 9983.750406239902, 10175.745606359604, 10186.286959912735, 8105.311048560939, 9988.400695958266, 10357.22320825926, 10420.166386688896, 10444.529996150344, 6573.704183311858, 6771.356721111487, 6775.728970841111, 7068.187158476841, 7194.2086370498155, 6923.93076069253, 7925.0489941207425, 7999.680012799423, 8002.359811215205, 8153.55155466455, 7354.0, 7513.248675132443, 7547.132079810673, 7608.2391760823475, 7681.116671582839, 7332.991492136678, 7353.632318384166, 7411.925880741123, 7441.1070671519765, 7512.5492470451945, 5839.445252700986, 7023.613701246481, 7024.0, 7025.859482810213, 7027.262137475492, 4424.5133035366725, 4797.2564252540915, 4877.292792545132, 4899.11815873132, 4982.701037937735, 4881.194602890483, 4930.433000204879, 4998.2002879539095, 5039.571636410946, 5067.594592432671], "value": 4575.608971225471, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.81964714876014, 298.40914988323107, 305.8623619371283, 309.23155957445755, 314.82212549909315, 4948.430930443, 5097.821576244833, 5189.455107213745, 5241.885120180659, 5249.160134378495, 4181.581841815824, 4916.360873086503, 5003.374578177728, 5075.238714192873, 5199.102327650408, 3557.9186176086955, 3658.5426821647293, 4013.374583293756, 4032.5362583303004, 4041.4746083009168, 3690.8892733218045, 4010.1928649945007, 4018.859339923103, 4031.0124019615087, 4036.777977211252, 3045.9695403046017, 3483.7387195960277, 3866.3427217372973, 3932.626400491963, 3951.3601855230045, 3254.300325430044, 3438.3123375324785, 3888.655756049795, 3904.8871071744416, 3929.8035098244973, 3414.897553073412, 3424.5787997981056, 3426.7429942754393, 3434.3131373725355, 3439.2605589798313, 4951.158303088484, 5044.571211447032, 5070.594352451795, 5077.873053173664, 5149.476756389379, 3607.971728057491, 3710.942381421309, 4207.747535147871, 4500.864974050751, 4526.7283962962, 4805.351277577517, 5048.899022019539, 5470.261514695545, 5470.699111548864, 5500.917486237709, 3143.842807859598, 3255.788373755722, 3543.4684797280356, 3745.1760612665444, 3776.2825063237897, 4720.409948756405, 4765.761711914391, 5301.072312345363, 5670.319561652587, 5810.970945145247, 3454.547271437257, 3506.3162683276514, 3788.242351529705, 3819.923601527954, 3833.4249862520287, 3195.3609278144463, 3828.8659896904032, 3894.4353068804867, 3902.5267511914417, 3918.138009637932, 3975.7614543127506, 4334.50153232376, 4436.334549817553, 4481.910361792811, 4484.798184081724, 4654.464736555272, 5448.727563621803, 5517.69652669107, 5525.972370138204, 5538.723063846792, 1042.5725452564411, 1226.4235809169677, 1227.594404406949, 1285.6721536008258, 1294.76046931318, 867.3148212911855, 878.2622597018535, 885.4996926736374, 886.7295474880094, 887.3761017338255, 4246.534945443878, 4782.856514304576, 4858.036597675416, 5213.601743198095, 5213.661112027706, 4871.903821640173, 5117.824924407187, 5161.0, 5365.0, 5692.8861422771315, 4386.0, 4616.168580078527, 5126.8974620508125, 5146.536811686966, 5151.5106064923775, 2082.302428686407, 2408.4701365699516, 2416.5650182966883, 2446.584080706284, 2465.977898123557, 4415.952992435209, 4455.643548516111, 4581.62551234635, 4694.342792009122, 5258.579313654898, 4892.877678058077, 4911.961535962607, 5823.475887170175, 5883.117402431181, 5889.352171261158, 5192.818251361185, 5439.782408703687, 5963.105534169909, 5969.970150149222, 5985.730642121028, 5314.441983591822, 5695.373508914099, 5774.82675519735, 5784.21913041734, 5794.0, 5185.403678576861, 5658.717064146858, 5672.149177623224, 5673.0, 5674.404187560247, 5646.745896434588, 5932.525397968066, 5968.075642935018, 6031.336552979081, 6035.818925432244, 3195.392875353675, 3743.9625603744703, 3759.661630453272, 3812.5234345706785, 3830.4637350771472, 5032.6980381177245, 5637.350445290706, 5693.032184528723, 5699.430056994267, 5728.627639203439, 5266.07843627356, 5527.640703354269, 5528.004959107399, 5562.527185189304, 5606.887862242651, 5163.638545301793, 5315.893682126259, 5538.781468077017, 5557.610967232255, 5589.664620122806, 4843.806247750051, 4969.428515720739, 5091.66904151229, 5312.7343632818975, 5433.293671822637, 4554.470285528741, 4579.839705610288, 4965.4041515018425, 5190.792368305377, 5355.812546560852, 4839.60439582409, 4977.900441991213, 5377.848860455849, 5428.402875683592, 5456.508914197741], "value": 3923.1501922840735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.9062821833161, 762.7216066135859, 790.9169537198594, 805.5851236613141, 833.69570106911, 14123.223222722747, 14505.347259373328, 14572.27138643069, 14616.415343386265, 14725.0, 14667.853321466782, 15290.770638440405, 15500.302486388111, 15748.212589370514, 15787.368505259805, 853.4282031039203, 880.137465284022, 880.6345366672823, 882.3029806452895, 882.9779255518631, 690.602903330587, 710.350029722803, 711.9747563508531, 713.985720285594, 714.5783987447431, 744.0587656614388, 882.7307671160294, 909.2680392284209, 910.4127837544779, 916.9174774270315, 902.2015516268117, 902.7788191893028, 902.7923577577128, 903.5166186090443, 905.343625871238, 675.9898601520981, 677.14003215916, 677.8915373540259, 677.949153813466, 682.1405029662611, 12086.033117350591, 12451.190672606343, 12466.501339946391, 12652.936735316356, 12682.682932926658, 13200.603981880462, 13779.379927903168, 13965.79051314231, 14267.643308917257, 14373.30415098871, 11423.320114672706, 11584.131190160771, 11680.591179308769, 11965.40172991347, 12077.033837292995, 3830.028779987459, 3885.164689591723, 3898.493195884545, 3965.5637879833193, 3995.320795464778, 81114.0, 83346.0, 83583.16416835814, 90523.54738226267, 110470.0, 10684.732881678021, 10718.464076796128, 10725.895972090006, 10857.891421085846, 10887.292325998786, 21281.78718212798, 22147.557048858933, 22150.667739983914, 22169.0, 22171.445713857283, 7716.884246736304, 7751.651175697107, 7824.37405007598, 7873.724419645285, 7948.880766788503, 4250.766207858597, 4284.400183974246, 4356.586124318184, 4372.846950356722, 4598.425196850394, 3529.3294274087843, 3587.3722098633157, 3636.5272514573467, 3637.690796282293, 3643.906827951657, 626.4049153304379, 649.3279455763262, 662.3442791636342, 663.2008429842028, 668.8361351468824, 571.5456212311223, 598.7186022569385, 617.6942413505344, 652.4943169044029, 668.2916108924555, 9115.225205857576, 9547.379420337656, 9586.328956972944, 9610.27015137282, 9635.421874687541, 575.3211210771331, 631.6494345638123, 640.452413186728, 666.8299583606149, 686.193722376206, 4197.538270790211, 4602.010567727954, 4669.276262179367, 4675.976620116878, 4687.859364219079, 121119.0, 129569.0, 151321.0, 152827.0, 161704.0, 79307.0, 81675.0, 96743.0, 128097.35951320184, 131307.343463284, 98259.50870245603, 101000.0, 102235.4888225569, 104336.47831760792, 107060.0, 9441.15029647335, 10019.649312274036, 10071.949640252045, 10081.0, 10090.2432317575, 55546.9449180299, 58749.706251468466, 61100.0, 61728.69135654293, 62230.0, 60989.0, 76375.61812190904, 89154.55422722845, 92313.53843230741, 94586.52706736422, 11227.7754444909, 12389.876101239233, 12823.358832058546, 13175.868241317847, 13565.02298099129, 14480.782788258395, 14610.415583376545, 14665.753410960187, 14707.705845883236, 14732.0, 13290.0, 13390.0, 13400.06199566021, 13482.595522134352, 14201.502947396792, 13270.734585308433, 13561.0, 13881.791773123614, 14045.438182472586, 14311.0, 11589.536418543501, 12380.394066154711, 12696.936515317733, 13699.315034248448, 13946.372413241226, 10338.793224135325, 10658.62694805678, 11420.657380278604, 11487.54049837997, 11492.080633549464, 10641.414722190353, 10783.921607839153, 11220.382878941737, 11484.0, 11710.0], "value": 7623.18186573498, "unit": "score"}], "name": "dromaeo_css", "value": 7203.061506253274, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 111.0, 115.0, 114.0, 113.0, 113.0, 112.0, 111.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 109.0, 142.0, 128.0, 144.0, 109.0, 108.0, 142.0, 106.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 185.0, 185.0, 184.0, 182.0, 184.0, 184.0, 184.0, 183.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 58.0, 87.0, 64.0, 77.0, 81.0, 80.0, 109.0, 57.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 95.0, 68.0, 68.0, 68.0, 92.0, 69.0, 80.0, 120.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 84.0, 87.0, 83.0, 87.0, 84.0, 100.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 96.0, 94.0, 94.0, 117.0, 159.0, 95.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 84.0, 86.0, 83.0, 84.0, 83.0, 86.0, 84.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 56.0, 55.0, 56.0, 59.0, 58.0, 58.0, 57.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 66.0, 75.0, 71.0, 70.0, 69.0, 71.0, 71.0, 71.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 87.0, 88.0, 100.0, 77.0, 83.0, 95.0, 103.0, 102.0, 100.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 137.0, 150.0, 150.0, 146.0, 149.0, 155.0, 168.0, 137.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 164.0, 171.0, 163.0, 162.0, 162.0, 165.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 71.0, 86.0, 85.0, 75.0, 66.0, 66.0, 66.0, 66.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1454.5, "alertThreshold": 2.0}]} 16:26:15 INFO - Return code: 0 16:26:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:26:15 INFO - # TBPL SUCCESS # 16:26:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:26:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:26:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:26:15 INFO - 2016-10-19 16:26:15.630 screenresolution[1662:9857] starting screenresolution argv=screenresolution get 16:26:15 INFO - 2016-10-19 16:26:15.633 screenresolution[1662:9857] Display 0: 1600x1200x32@60 16:26:15 INFO - 2016-10-19 16:26:15.639 screenresolution[1663:9860] starting screenresolution argv=screenresolution list 16:26:15 INFO - Available Modes on Display 0 16:26:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:26:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:26:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:26:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:26:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:26:15 INFO - Intel Iris: 16:26:15 INFO - Chipset Model: Intel Iris 16:26:15 INFO - Type: GPU 16:26:15 INFO - Bus: Built-In 16:26:15 INFO - VRAM (Dynamic, Max): 1536 MB 16:26:15 INFO - Vendor: Intel (0x8086) 16:26:15 INFO - Device ID: 0x0a2e 16:26:15 INFO - Revision ID: 0x0009 16:26:15 INFO - Displays: 16:26:15 INFO - Display: 16:26:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:26:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:26:15 INFO - Display Serial Number: 1600x1200 60 16:26:15 INFO - Main Display: Yes 16:26:15 INFO - Mirror: Off 16:26:15 INFO - Online: Yes 16:26:15 INFO - Rotation: Supported 16:26:15 INFO - Return code: 0 16:26:15 INFO - Running post-action listener: _resource_record_post_action 16:26:15 INFO - [mozharness: 2016-10-19 23:26:15.875934Z] Finished run-tests step (success) 16:26:15 INFO - Running post-run listener: _resource_record_post_run 16:26:15 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37053440; Write bytes: 662984192; Read time: 240; Write time: 1886 16:26:15 INFO - TinderboxPrint: CPU usage
53.6% 16:26:15 INFO - TinderboxPrint: I/O read bytes / time
37,053,440 / 240 16:26:15 INFO - TinderboxPrint: I/O write bytes / time
662,984,192 / 1,886 16:26:15 INFO - TinderboxPrint: CPU idle
2,242.9 (46.4%) 16:26:15 INFO - TinderboxPrint: CPU system
973.0 (20.1%) 16:26:15 INFO - TinderboxPrint: CPU user
1,617.7 (33.5%) 16:26:15 INFO - TinderboxPrint: Swap in / out
400,797,696 / 0 16:26:15 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360755712; Write bytes: 356608000; Read time: 27600; Write time: 739 16:26:15 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 34964480; Write bytes: 294956544; Read time: 221; Write time: 1109 16:26:16 INFO - Running post-run listener: _upload_blobber_files 16:26:16 INFO - Blob upload gear active. 16:26:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:26:16 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 16:26:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:26:16 INFO - (blobuploader) - INFO - Open directory for files ... 16:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:17 INFO - (blobuploader) - INFO - Done attempting. 16:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:26:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:18 INFO - (blobuploader) - INFO - Done attempting. 16:26:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:26:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:21 INFO - (blobuploader) - INFO - Done attempting. 16:26:21 INFO - (blobuploader) - INFO - Iteration through files over. 16:26:21 INFO - Return code: 0 16:26:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:26:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:26:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5508f61b5d0f44fbe6d1c12de507922892d2749c5075b0adb32945952170419947f3f7941357387da5e30ebb8f086d212a2bcfb3dac2f824ed21d93dc99a85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1ef5f3461e2e5ae01a2ccd3b2169989b439aa741b69c781811b5125c250e140a1aad04a391c2ff5e80fbc6f4e6117b8fdd2f4bc422c3d8828b5ef8b88fc58a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b9ed94a6fd8770db0d9c14ba78e85984d482cb17f7ca0927d8bb888558f07c11f084b7f20dc541a7d21d502bf6aab02bb669ca30d39a71ae1ad1a93f1b88af2"} 16:26:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:26:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:26:21 INFO - Contents: 16:26:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5508f61b5d0f44fbe6d1c12de507922892d2749c5075b0adb32945952170419947f3f7941357387da5e30ebb8f086d212a2bcfb3dac2f824ed21d93dc99a85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1ef5f3461e2e5ae01a2ccd3b2169989b439aa741b69c781811b5125c250e140a1aad04a391c2ff5e80fbc6f4e6117b8fdd2f4bc422c3d8828b5ef8b88fc58a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b9ed94a6fd8770db0d9c14ba78e85984d482cb17f7ca0927d8bb888558f07c11f084b7f20dc541a7d21d502bf6aab02bb669ca30d39a71ae1ad1a93f1b88af2"} 16:26:21 INFO - Running post-run listener: copy_logs_to_upload_dir 16:26:21 INFO - Copying logs to upload dir... 16:26:21 INFO - mkdir: /builds/slave/test/build/upload/logs 16:26:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.947167 ========= master_lag: 2.20 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-19 16:26:23.523318) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 16:26:23.524473) ========= 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.GAvRJvkgAo/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.94LhLQVA28/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5508f61b5d0f44fbe6d1c12de507922892d2749c5075b0adb32945952170419947f3f7941357387da5e30ebb8f086d212a2bcfb3dac2f824ed21d93dc99a85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1ef5f3461e2e5ae01a2ccd3b2169989b439aa741b69c781811b5125c250e140a1aad04a391c2ff5e80fbc6f4e6117b8fdd2f4bc422c3d8828b5ef8b88fc58a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b9ed94a6fd8770db0d9c14ba78e85984d482cb17f7ca0927d8bb888558f07c11f084b7f20dc541a7d21d502bf6aab02bb669ca30d39a71ae1ad1a93f1b88af2"} build_url:https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010997 build_url: 'https://queue.taskcluster.net/v1/task/D6rmDZ25R-OUu8_jXeX2iA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5508f61b5d0f44fbe6d1c12de507922892d2749c5075b0adb32945952170419947f3f7941357387da5e30ebb8f086d212a2bcfb3dac2f824ed21d93dc99a85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1ef5f3461e2e5ae01a2ccd3b2169989b439aa741b69c781811b5125c250e140a1aad04a391c2ff5e80fbc6f4e6117b8fdd2f4bc422c3d8828b5ef8b88fc58a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b9ed94a6fd8770db0d9c14ba78e85984d482cb17f7ca0927d8bb888558f07c11f084b7f20dc541a7d21d502bf6aab02bb669ca30d39a71ae1ad1a93f1b88af2"}' ========= master_lag: 0.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 16:26:24.070008) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:26:24.070327) ========= 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.GAvRJvkgAo/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.94LhLQVA28/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.005075 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:26:24.095460) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 16:26:24.095751) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 16:26:24.099072) ========= ========= Total master_lag: 2.83 =========