builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0312 starttime: 1477649161.64 results: success (0) buildid: 20161028004017 builduid: ac45770108a94f8bae0d47030c43f04b revision: 4af3cec722c07b291d41f6fd7ba727b17e2cb613 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:01.638716) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:01.639184) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:01.639466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:01.666113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:01.666516) ========= 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.M3f6xzH47p/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.rPzO29AAWY/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-28 03:06:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.2M=0.001s 2016-10-28 03:06:02 (19.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.474986 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:02.164488) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:02.164824) ========= 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.M3f6xzH47p/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.rPzO29AAWY/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.033639 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:02.219460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 03:06:02.219823) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4af3cec722c07b291d41f6fd7ba727b17e2cb613 --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 4af3cec722c07b291d41f6fd7ba727b17e2cb613 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.M3f6xzH47p/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.rPzO29AAWY/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-28 03:06:02,305 truncating revision to first 12 chars 2016-10-28 03:06:02,305 Setting DEBUG logging. 2016-10-28 03:06:02,305 attempt 1/10 2016-10-28 03:06:02,305 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4af3cec722c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 03:06:03,795 unpacking tar archive at: mozilla-aurora-4af3cec722c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.749368 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 03:06:03.991975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:03.992293) ========= script_repo_revision: 4af3cec722c07b291d41f6fd7ba727b17e2cb613 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:03.992698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:03.992972) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 03:06:04.011472) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-28 03:06:04.011937) ========= /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.M3f6xzH47p/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.rPzO29AAWY/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 03:06:04 INFO - MultiFileLogger online at 20161028 03:06:04 in /builds/slave/test 03:06:04 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 03:06:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:06:04 INFO - {'append_to_log': False, 03:06:04 INFO - 'base_work_dir': '/builds/slave/test', 03:06:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:06:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:06:04 INFO - 'branch': 'Mozilla-Aurora', 03:06:04 INFO - 'buildbot_json_path': 'buildprops.json', 03:06:04 INFO - 'config_files': ('talos/mac_config.py',), 03:06:04 INFO - 'default_actions': ('clobber', 03:06:04 INFO - 'read-buildbot-config', 03:06:04 INFO - 'download-and-extract', 03:06:04 INFO - 'populate-webroot', 03:06:04 INFO - 'create-virtualenv', 03:06:04 INFO - 'install', 03:06:04 INFO - 'run-tests'), 03:06:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:06:04 INFO - 'download_minidump_stackwalk': True, 03:06:04 INFO - 'download_symbols': 'ondemand', 03:06:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:06:04 INFO - 'tooltool.py': '/tools/tooltool.py', 03:06:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:06:04 INFO - '/tools/misc-python/virtualenv.py')}, 03:06:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:06:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:06:04 INFO - 'installer_path': 'installer.exe', 03:06:04 INFO - 'log_level': 'info', 03:06:04 INFO - 'log_name': 'talos', 03:06:04 INFO - 'log_to_console': True, 03:06:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:06:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:06:04 INFO - 'opt_config_files': (), 03:06:04 INFO - 'pip_index': False, 03:06:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:06:04 INFO - 'cmd': ('bash', 03:06:04 INFO - '-c', 03:06:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:06:04 INFO - 'enabled': True, 03:06:04 INFO - 'halt_on_failure': False, 03:06:04 INFO - 'name': 'check_screen_resolution'},), 03:06:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:06:04 INFO - 'cmd': ('bash', 03:06:04 INFO - '-c', 03:06:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:06:04 INFO - 'enabled': True, 03:06:04 INFO - 'halt_on_failure': False, 03:06:04 INFO - 'name': 'check_screen_resolution'},), 03:06:04 INFO - 'run_cmd_checks_enabled': True, 03:06:04 INFO - 'sps_profile': False, 03:06:04 INFO - 'sps_profile_interval': 0, 03:06:04 INFO - 'suite': 'dromaeojs', 03:06:04 INFO - 'system_bits': '32', 03:06:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:06:04 INFO - 'title': 't-yosemite-r7-0312', 03:06:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:06:04 INFO - 'use_talos_json': True, 03:06:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:06:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:06:04 INFO - 'work_dir': 'build'} 03:06:04 INFO - [mozharness: 2016-10-28 10:06:04.207705Z] Running clobber step. 03:06:04 INFO - Running pre-action listener: _resource_record_pre_action 03:06:04 INFO - Running main action method: clobber 03:06:04 INFO - rmtree: /builds/slave/test/build 03:06:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:06:06 INFO - Running post-action listener: _resource_record_post_action 03:06:06 INFO - [mozharness: 2016-10-28 10:06:06.476430Z] Finished clobber step (success) 03:06:06 INFO - [mozharness: 2016-10-28 10:06:06.476764Z] Running read-buildbot-config step. 03:06:06 INFO - Running pre-action listener: _resource_record_pre_action 03:06:06 INFO - Running main action method: read_buildbot_config 03:06:06 INFO - Using buildbot properties: 03:06:06 INFO - { 03:06:06 INFO - "project": "", 03:06:06 INFO - "product": "firefox", 03:06:06 INFO - "script_repo_revision": "production", 03:06:06 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:06:06 INFO - "repository": "", 03:06:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:06:06 INFO - "buildid": "20161028004017", 03:06:06 INFO - "stage_platform": "macosx64", 03:06:06 INFO - "basedir": "/builds/slave/test", 03:06:06 INFO - "nightly_build": "True", 03:06:06 INFO - "buildnumber": 53, 03:06:06 INFO - "slavename": "t-yosemite-r7-0312", 03:06:06 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:06:06 INFO - "platform": "yosemite_r7", 03:06:06 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:06:06 INFO - "branch": "mozilla-aurora", 03:06:06 INFO - "repo_path": "releases/mozilla-aurora", 03:06:06 INFO - "revision": "4af3cec722c07b291d41f6fd7ba727b17e2cb613", 03:06:06 INFO - "pgo_build": "False", 03:06:06 INFO - "builduid": "ac45770108a94f8bae0d47030c43f04b", 03:06:06 INFO - "slavebuilddir": "test" 03:06:06 INFO - } 03:06:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:06:06 INFO - Running post-action listener: _resource_record_post_action 03:06:06 INFO - [mozharness: 2016-10-28 10:06:06.482615Z] Finished read-buildbot-config step (success) 03:06:06 INFO - [mozharness: 2016-10-28 10:06:06.482835Z] Running download-and-extract step. 03:06:06 INFO - Running pre-action listener: _resource_record_pre_action 03:06:06 INFO - Running main action method: download_and_extract 03:06:06 INFO - mkdir: /builds/slave/test/build/tests 03: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')]} 03:06:06 INFO - trying https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:06:06 INFO - Downloading https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/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 03:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/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 03:06:08 INFO - Downloaded 1199 bytes. 03:06:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:06:08 INFO - Using the following test package requirements: 03:06:08 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:06:08 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:08 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:06:08 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:08 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:06:08 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:08 INFO - u'jsshell-mac.zip'], 03:06:08 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:08 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:06:08 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:06:08 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:08 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:06:08 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:08 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:06:08 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:08 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:06:08 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:06:08 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:06:08 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:06:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:06:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:06:08 INFO - Fetch https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:06:08 INFO - Expected file size: 16420405 03:06:16 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 03:06:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:06:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:06:16 INFO - Fetch https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:06:17 INFO - Expected file size: 16420405 03:06:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:06:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:06:23 INFO - Fetch https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:06:24 INFO - Expected file size: 14414081 03:06:25 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')]} 03:06:25 INFO - trying https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:06:25 INFO - Downloading https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/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 03:06:27 INFO - Downloaded 115524997 bytes. 03:06:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:06:27 INFO - mkdir: /builds/slave/test/properties 03:06:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:06:27 INFO - Writing to file /builds/slave/test/properties/build_url 03:06:27 INFO - Contents: 03:06:27 INFO - build_url:https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:06:28 INFO - Running post-action listener: _resource_record_post_action 03:06:28 INFO - Running post-action listener: set_extra_try_arguments 03:06:28 INFO - [mozharness: 2016-10-28 10:06:28.606758Z] Finished download-and-extract step (success) 03:06:28 INFO - [mozharness: 2016-10-28 10:06:28.606913Z] Running populate-webroot step. 03:06:28 INFO - Running pre-action listener: _resource_record_pre_action 03:06:28 INFO - Running main action method: populate_webroot 03:06:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:06:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:06:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:06:28 INFO - '--tppagecycles', 03:06:28 INFO - '7'], 03:06:28 INFO - 'tests': ['tsvgm']}}, 03:06:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:06:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:06:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:06:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:06:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:06:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:06:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:28 INFO - 'talos_options': ['--disable-e10s'], 03:06:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:28 INFO - 'talos_options': ['--disable-e10s'], 03:06:28 INFO - 'tests': ['damp', 'tps']}, 03:06:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:28 INFO - 'tests': ['damp', 'tps']}, 03:06:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:06:28 INFO - 'tests': ['dromaeo_dom']}, 03:06:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:06:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:06:28 INFO - 'tests': ['basic_compositor_video']}, 03:06:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:06:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:06:28 INFO - 'tests': ['a11yr', 03:06:28 INFO - 'ts_paint', 03:06:28 INFO - 'tpaint', 03:06:28 INFO - 'sessionrestore', 03:06:28 INFO - 'sessionrestore_no_auto_restore', 03:06:28 INFO - 'tabpaint']}, 03:06:28 INFO - 'other-e10s': {'tests': ['a11yr', 03:06:28 INFO - 'ts_paint', 03:06:28 INFO - 'tpaint', 03:06:28 INFO - 'sessionrestore', 03:06:28 INFO - 'sessionrestore_no_auto_restore', 03:06:28 INFO - 'tabpaint']}, 03:06:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:06:28 INFO - 'ts_paint', 03:06:28 INFO - 'tpaint', 03:06:28 INFO - 'sessionrestore', 03:06:28 INFO - 'sessionrestore_no_auto_restore', 03:06:28 INFO - 'tabpaint']}, 03:06:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:06:28 INFO - 'ts_paint', 03:06:28 INFO - 'tpaint', 03:06:28 INFO - 'sessionrestore', 03:06:28 INFO - 'sessionrestore_no_auto_restore', 03:06:28 INFO - 'tabpaint']}, 03:06:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:06:28 INFO - 'tests': ['a11yr', 03:06:28 INFO - 'ts_paint', 03:06:28 INFO - 'tpaint', 03:06:28 INFO - 'sessionrestore', 03:06:28 INFO - 'sessionrestore_no_auto_restore', 03:06:28 INFO - 'tabpaint']}, 03:06:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:06:28 INFO - 'tests': ['a11yr', 03:06:28 INFO - 'ts_paint', 03:06:28 INFO - 'tpaint', 03:06:28 INFO - 'sessionrestore', 03:06:28 INFO - 'sessionrestore_no_auto_restore', 03:06:28 INFO - 'tabpaint']}, 03:06:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:06:28 INFO - 'tests': ['tsvgx', 03:06:28 INFO - 'tsvgr_opacity', 03:06:28 INFO - 'tart', 03:06:28 INFO - 'tscrollx', 03:06:28 INFO - 'cart']}, 03:06:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:06:28 INFO - 'tsvgr_opacity', 03:06:28 INFO - 'tart', 03:06:28 INFO - 'tscrollx', 03:06:28 INFO - 'cart']}, 03:06:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:28 INFO - 'talos_options': ['--disable-e10s'], 03:06:28 INFO - 'tests': ['tp5o']}, 03:06:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:28 INFO - 'tests': ['tp5o']}, 03:06:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:28 INFO - 'talos_options': ['--disable-e10s', 03:06:28 INFO - '--xperf_path', 03:06:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:28 INFO - 'tests': ['tp5n']}, 03:06:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:28 INFO - 'talos_options': ['--xperf_path', 03:06:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:28 INFO - 'tests': ['tp5n']}}, 03:06:28 INFO - 'talos.zip': {'path': '', 03:06:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:06:28 INFO - Running post-action listener: _resource_record_post_action 03:06:28 INFO - [mozharness: 2016-10-28 10:06:28.626268Z] Finished populate-webroot step (success) 03:06:28 INFO - [mozharness: 2016-10-28 10:06:28.626398Z] Running create-virtualenv step. 03:06:28 INFO - Running pre-action listener: _resource_record_pre_action 03:06:28 INFO - Running main action method: create_virtualenv 03:06:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:06:28 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 03:06:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:06:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:06:28 INFO - Using real prefix '/tools/python27' 03:06:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:06:29 INFO - Installing distribute.............................................................................................................................................................................................done. 03:06:32 INFO - Installing pip.................done. 03:06:32 INFO - Return code: 0 03:06:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:06:32 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')]} 03:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:32 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')]} 03:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:32 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 0x102e5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2da4bd6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c71d30>, '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 0x102ad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c69b20>, '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.M3f6xzH47p/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.rPzO29AAWY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 03:06:32 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 03:06:32 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 03:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3f6xzH47p/Render', 03:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:32 INFO - 'HOME': '/Users/cltbld', 03:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:32 INFO - 'LOGNAME': 'cltbld', 03:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:32 INFO - 'MOZ_NO_REMOTE': '1', 03:06:32 INFO - 'NO_EM_RESTART': '1', 03:06:32 INFO - 'PAGER': '/bin/cat', 03:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:32 INFO - 'PWD': '/builds/slave/test', 03:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:32 INFO - 'SHELL': '/bin/bash', 03:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rPzO29AAWY/Listeners', 03:06:32 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 03:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:32 INFO - 'USER': 'cltbld', 03:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:32 INFO - 'XPC_FLAGS': '0x0', 03:06:32 INFO - 'XPC_SERVICE_NAME': '0', 03:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:32 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 03:06:32 INFO - Cleaning up... 03:06:32 INFO - Return code: 0 03:06:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:06:32 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')]} 03:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:32 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')]} 03:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:32 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 0x102e5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2da4bd6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c71d30>, '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 0x102ad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c69b20>, '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.M3f6xzH47p/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.rPzO29AAWY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 03:06:32 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 03:06:32 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 03:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3f6xzH47p/Render', 03:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:32 INFO - 'HOME': '/Users/cltbld', 03:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:32 INFO - 'LOGNAME': 'cltbld', 03:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:32 INFO - 'MOZ_NO_REMOTE': '1', 03:06:32 INFO - 'NO_EM_RESTART': '1', 03:06:32 INFO - 'PAGER': '/bin/cat', 03:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:32 INFO - 'PWD': '/builds/slave/test', 03:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:32 INFO - 'SHELL': '/bin/bash', 03:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rPzO29AAWY/Listeners', 03:06:32 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 03:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:32 INFO - 'USER': 'cltbld', 03:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:32 INFO - 'XPC_FLAGS': '0x0', 03:06:32 INFO - 'XPC_SERVICE_NAME': '0', 03:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:32 INFO - Downloading/unpacking psutil>=3.1.1 03:06:32 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 03:06:32 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 03:06:32 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 03:06:32 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 03:06:32 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 03:06:32 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 03:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:06:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:36 INFO - Installing collected packages: psutil 03:06:36 INFO - Running setup.py install for psutil 03:06:36 INFO - building 'psutil._psutil_osx' extension 03:06:36 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 03:06:36 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 03:06:37 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 03:06:37 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 03:06:37 INFO - building 'psutil._psutil_posix' extension 03:06:37 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 03:06:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:06:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:06:37 INFO - ^ 03:06:37 INFO - 1 warning generated. 03:06:37 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 03:06:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:37 INFO - Successfully installed psutil 03:06:37 INFO - Cleaning up... 03:06:37 INFO - Return code: 0 03:06:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:06:37 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')]} 03:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:37 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')]} 03:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:37 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 0x102e5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2da4bd6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c71d30>, '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 0x102ad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c69b20>, '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.M3f6xzH47p/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.rPzO29AAWY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 03:06:37 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 03:06:37 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 03:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3f6xzH47p/Render', 03:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:37 INFO - 'HOME': '/Users/cltbld', 03:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:37 INFO - 'LOGNAME': 'cltbld', 03:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:37 INFO - 'MOZ_NO_REMOTE': '1', 03:06:37 INFO - 'NO_EM_RESTART': '1', 03:06:37 INFO - 'PAGER': '/bin/cat', 03:06:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:37 INFO - 'PWD': '/builds/slave/test', 03:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:37 INFO - 'SHELL': '/bin/bash', 03:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rPzO29AAWY/Listeners', 03:06:37 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 03:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:37 INFO - 'USER': 'cltbld', 03:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:37 INFO - 'XPC_FLAGS': '0x0', 03:06:37 INFO - 'XPC_SERVICE_NAME': '0', 03:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:06:37 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 03:06:37 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 03:06:37 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 03:06:37 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 03:06:37 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 03:06:37 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 03:06:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:06:40 INFO - Installing collected packages: mozsystemmonitor 03:06:40 INFO - Running setup.py install for mozsystemmonitor 03:06:40 INFO - Successfully installed mozsystemmonitor 03:06:40 INFO - Cleaning up... 03:06:40 INFO - Return code: 0 03:06:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102e5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2da4bd6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c71d30>, '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 0x102ad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c69b20>, '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.M3f6xzH47p/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.rPzO29AAWY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 03:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:06:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3f6xzH47p/Render', 03:06:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:40 INFO - 'HOME': '/Users/cltbld', 03:06:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:40 INFO - 'LOGNAME': 'cltbld', 03:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:40 INFO - 'MOZ_NO_REMOTE': '1', 03:06:40 INFO - 'NO_EM_RESTART': '1', 03:06:40 INFO - 'PAGER': '/bin/cat', 03:06:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:40 INFO - 'PWD': '/builds/slave/test', 03:06:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:40 INFO - 'SHELL': '/bin/bash', 03:06:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rPzO29AAWY/Listeners', 03:06:40 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 03:06:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:40 INFO - 'USER': 'cltbld', 03:06:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:40 INFO - 'XPC_FLAGS': '0x0', 03:06:40 INFO - 'XPC_SERVICE_NAME': '0', 03:06:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:40 INFO - Downloading/unpacking jsonschema==2.5.1 03:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:06:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:43 INFO - Downloading functools32-3.2.3-2.tar.gz 03:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:06:43 INFO - warning: no files found matching '*.txt' 03:06:43 INFO - no previously-included directories found matching 'build' 03:06:43 INFO - no previously-included directories found matching 'dist' 03:06:43 INFO - no previously-included directories found matching '.git*' 03:06:43 INFO - Installing collected packages: jsonschema, functools32 03:06:43 INFO - Running setup.py install for functools32 03:06:44 INFO - warning: no files found matching '*.txt' 03:06:44 INFO - no previously-included directories found matching 'build' 03:06:44 INFO - no previously-included directories found matching 'dist' 03:06:44 INFO - no previously-included directories found matching '.git*' 03:06:44 INFO - Successfully installed jsonschema functools32 03:06:44 INFO - Cleaning up... 03:06:44 INFO - Return code: 0 03:06:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:06: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')]} 03:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06: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')]} 03:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06: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', '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 0x102e5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2da4bd6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c71d30>, '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 0x102ad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c69b20>, '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.M3f6xzH47p/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.rPzO29AAWY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 03:06: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:06: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 functools32==3.2.3-2 03:06:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3f6xzH47p/Render', 03:06:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:44 INFO - 'HOME': '/Users/cltbld', 03:06:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:44 INFO - 'LOGNAME': 'cltbld', 03:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:44 INFO - 'MOZ_NO_REMOTE': '1', 03:06:44 INFO - 'NO_EM_RESTART': '1', 03:06:44 INFO - 'PAGER': '/bin/cat', 03:06:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:44 INFO - 'PWD': '/builds/slave/test', 03:06:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:44 INFO - 'SHELL': '/bin/bash', 03:06:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rPzO29AAWY/Listeners', 03:06:44 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 03:06:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:44 INFO - 'USER': 'cltbld', 03:06:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:44 INFO - 'XPC_FLAGS': '0x0', 03:06:44 INFO - 'XPC_SERVICE_NAME': '0', 03:06:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:06:44 INFO - Cleaning up... 03:06:44 INFO - Return code: 0 03:06:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:06: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')]} 03:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06: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')]} 03:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06: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', '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 0x102e5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2da4bd6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c71d30>, '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 0x102ad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c69b20>, '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.M3f6xzH47p/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.rPzO29AAWY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 03:06: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:06: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 blobuploader==1.2.4 03:06:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3f6xzH47p/Render', 03:06:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:44 INFO - 'HOME': '/Users/cltbld', 03:06:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:44 INFO - 'LOGNAME': 'cltbld', 03:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:44 INFO - 'MOZ_NO_REMOTE': '1', 03:06:44 INFO - 'NO_EM_RESTART': '1', 03:06:44 INFO - 'PAGER': '/bin/cat', 03:06:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:44 INFO - 'PWD': '/builds/slave/test', 03:06:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:44 INFO - 'SHELL': '/bin/bash', 03:06:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rPzO29AAWY/Listeners', 03:06:44 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 03:06:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:44 INFO - 'USER': 'cltbld', 03:06:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:44 INFO - 'XPC_FLAGS': '0x0', 03:06:44 INFO - 'XPC_SERVICE_NAME': '0', 03:06:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:44 INFO - Downloading/unpacking blobuploader==1.2.4 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:06:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:06:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:06:48 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 03:06:48 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 03:06:48 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 03:06:48 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 03:06:48 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 03:06:48 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 03:06:48 INFO - Downloading docopt-0.6.1.tar.gz 03:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:06:48 INFO - Installing collected packages: blobuploader, requests, docopt 03:06:48 INFO - Running setup.py install for blobuploader 03:06:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:06:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:06:48 INFO - Running setup.py install for requests 03:06:49 INFO - Running setup.py install for docopt 03:06:49 INFO - Successfully installed blobuploader requests docopt 03:06:49 INFO - Cleaning up... 03:06:49 INFO - Return code: 0 03:06:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:49 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 0x102e5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2da4bd6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c71d30>, '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 0x102ad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c69b20>, '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.M3f6xzH47p/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.rPzO29AAWY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 03:06:49 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 03:06:49 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 03:06:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3f6xzH47p/Render', 03:06:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:49 INFO - 'HOME': '/Users/cltbld', 03:06:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:49 INFO - 'LOGNAME': 'cltbld', 03:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:49 INFO - 'MOZ_NO_REMOTE': '1', 03:06:49 INFO - 'NO_EM_RESTART': '1', 03:06:49 INFO - 'PAGER': '/bin/cat', 03:06:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:49 INFO - 'PWD': '/builds/slave/test', 03:06:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:49 INFO - 'SHELL': '/bin/bash', 03:06:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rPzO29AAWY/Listeners', 03:06:49 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 03:06:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:49 INFO - 'USER': 'cltbld', 03:06:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:49 INFO - 'XPC_FLAGS': '0x0', 03:06:49 INFO - 'XPC_SERVICE_NAME': '0', 03:06:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:06:49 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-knp83K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:06:49 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-UdVeYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:06:49 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-PNQKxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:06:50 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-s52bkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:06:50 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-iNYFX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:06:50 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-hnbd9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:06:50 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-kjWycV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:06:50 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-xRSjqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:06:50 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-C_C0B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:06:50 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-uqxZxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:06:50 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-S_qH_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:06:50 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-T2AYrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:06:50 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-T65KrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:06:51 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-eJALbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:51 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-2opAUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:06:51 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ct7Yzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:06:51 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-BZArsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:06:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:06:51 INFO - Running setup.py install for manifestparser 03:06:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:06:51 INFO - Running setup.py install for mozcrash 03:06:51 INFO - Running setup.py install for mozdebug 03:06:51 INFO - Running setup.py install for mozdevice 03:06:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Running setup.py install for mozfile 03:06:52 INFO - Running setup.py install for mozhttpd 03:06:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Running setup.py install for mozinfo 03:06:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Running setup.py install for mozInstall 03:06:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Running setup.py install for mozleak 03:06:52 INFO - Running setup.py install for mozlog 03:06:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:06:52 INFO - Running setup.py install for moznetwork 03:06:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:06:53 INFO - Running setup.py install for mozprocess 03:06:53 INFO - Running setup.py install for mozprofile 03:06:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:06:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:06:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:06:53 INFO - Running setup.py install for mozrunner 03:06:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:06:53 INFO - Running setup.py install for mozscreenshot 03:06:53 INFO - Running setup.py install for moztest 03:06:53 INFO - Running setup.py install for mozversion 03:06:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:06:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:06:54 INFO - Cleaning up... 03:06:54 INFO - Return code: 0 03:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:54 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 0x102e5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2da4bd6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c71d30>, '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 0x102ad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c69b20>, '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.M3f6xzH47p/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.rPzO29AAWY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 03:06:54 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 03:06:54 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 03:06:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3f6xzH47p/Render', 03:06:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:54 INFO - 'HOME': '/Users/cltbld', 03:06:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:54 INFO - 'LOGNAME': 'cltbld', 03:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:54 INFO - 'MOZ_NO_REMOTE': '1', 03:06:54 INFO - 'NO_EM_RESTART': '1', 03:06:54 INFO - 'PAGER': '/bin/cat', 03:06:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:54 INFO - 'PWD': '/builds/slave/test', 03:06:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:54 INFO - 'SHELL': '/bin/bash', 03:06:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rPzO29AAWY/Listeners', 03:06:54 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 03:06:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:54 INFO - 'USER': 'cltbld', 03:06:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:54 INFO - 'XPC_FLAGS': '0x0', 03:06:54 INFO - 'XPC_SERVICE_NAME': '0', 03:06:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:06:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-e2fSLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:06:54 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)) 03:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:06:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-URughc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:06:54 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)) 03:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:06:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-tv5rJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:06:54 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)) 03:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:06:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-q5y7Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:06:54 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)) 03:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:06:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-1cmZcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:06:54 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)) 03:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:06:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-huEPWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:06:54 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)) 03:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:06:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-it_bNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:06:55 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)) 03:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:06:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-KboHoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:06:55 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)) 03:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:06:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-fNTWaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:06:55 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)) 03:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:06:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-EW9Qyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:06:55 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)) 03:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:06:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-WjuGS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:06:55 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)) 03:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:06:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-zaJnWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:06:55 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)) 03:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:06:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-yInfYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:06:55 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)) 03:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:06:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-AVfz3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:06:55 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)) 03:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Njy9ZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:55 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)) 03:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:06:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-g2O4Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:06:56 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)) 03:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:06:56 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-GNnKkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:06:56 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)) 03:06:56 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)) 03:06:56 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)) 03:06:56 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)) 03:06:56 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)) 03:06:56 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)) 03:06:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:06:56 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 03:06:56 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 03:06:56 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 03:06:56 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 03:06:56 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 03:06:56 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 03:06:58 INFO - Downloading blessings-1.6.tar.gz 03:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:06:58 INFO - Installing collected packages: blessings 03:06:58 INFO - Running setup.py install for blessings 03:06:58 INFO - Successfully installed blessings 03:06:58 INFO - Cleaning up... 03:06:58 INFO - Return code: 0 03:06:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:06:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:06:59 INFO - Reading from file tmpfile_stdout 03:06:59 INFO - Current package versions: 03:06:59 INFO - blessings == 1.6 03:06:59 INFO - blobuploader == 1.2.4 03:06:59 INFO - docopt == 0.6.1 03:06:59 INFO - functools32 == 3.2.3-2 03:06:59 INFO - jsonschema == 2.5.1 03:06:59 INFO - manifestparser == 1.1 03:06:59 INFO - mozInstall == 1.12 03:06:59 INFO - mozcrash == 0.17 03:06:59 INFO - mozdebug == 0.1 03:06:59 INFO - mozdevice == 0.48 03:06:59 INFO - mozfile == 1.2 03:06:59 INFO - mozhttpd == 0.7 03:06:59 INFO - mozinfo == 0.9 03:06:59 INFO - mozleak == 0.1 03:06:59 INFO - mozlog == 3.4 03:06:59 INFO - moznetwork == 0.27 03:06:59 INFO - mozprocess == 0.23 03:06:59 INFO - mozprofile == 0.28 03:06:59 INFO - mozrunner == 6.12 03:06:59 INFO - mozscreenshot == 0.1 03:06:59 INFO - mozsystemmonitor == 0.3 03:06:59 INFO - moztest == 0.7 03:06:59 INFO - mozversion == 1.4 03:06:59 INFO - psutil == 3.1.1 03:06:59 INFO - requests == 1.2.3 03:06:59 INFO - wsgiref == 0.1.2 03:06:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:59 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 0x102e5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2da4bd6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c71d30>, '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 0x102ad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c69b20>, '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.M3f6xzH47p/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.rPzO29AAWY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 03:06:59 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 03:06:59 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 03:06:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3f6xzH47p/Render', 03:06:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:59 INFO - 'HOME': '/Users/cltbld', 03:06:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:59 INFO - 'LOGNAME': 'cltbld', 03:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:59 INFO - 'MOZ_NO_REMOTE': '1', 03:06:59 INFO - 'NO_EM_RESTART': '1', 03:06:59 INFO - 'PAGER': '/bin/cat', 03:06:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:59 INFO - 'PWD': '/builds/slave/test', 03:06:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:59 INFO - 'SHELL': '/bin/bash', 03:06:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rPzO29AAWY/Listeners', 03:06:59 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 03:06:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:59 INFO - 'USER': 'cltbld', 03:06:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:59 INFO - 'XPC_FLAGS': '0x0', 03:06:59 INFO - 'XPC_SERVICE_NAME': '0', 03:06:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:59 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)) 03:06:59 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)) 03:06:59 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)) 03:06:59 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)) 03:06:59 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)) 03:06:59 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)) 03:06:59 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)) 03:06:59 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)) 03:06:59 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)) 03:06:59 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)) 03:06:59 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)) 03:06:59 INFO - Cleaning up... 03:06:59 INFO - Return code: 0 03:06:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:59 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 0x102e5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2da4bd6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c71d30>, '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 0x102ad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c69b20>, '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.M3f6xzH47p/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.rPzO29AAWY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 03:06:59 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 03:06:59 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 03:06:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3f6xzH47p/Render', 03:06:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:59 INFO - 'HOME': '/Users/cltbld', 03:06:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:59 INFO - 'LOGNAME': 'cltbld', 03:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:59 INFO - 'MOZ_NO_REMOTE': '1', 03:06:59 INFO - 'NO_EM_RESTART': '1', 03:06:59 INFO - 'PAGER': '/bin/cat', 03:06:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:59 INFO - 'PWD': '/builds/slave/test', 03:06:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:59 INFO - 'SHELL': '/bin/bash', 03:06:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rPzO29AAWY/Listeners', 03:06:59 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 03:06:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:59 INFO - 'USER': 'cltbld', 03:06:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:59 INFO - 'XPC_FLAGS': '0x0', 03:06:59 INFO - 'XPC_SERVICE_NAME': '0', 03:06:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:06:59 INFO - Cleaning up... 03:06:59 INFO - Return code: 0 03:06:59 INFO - Running post-action listener: _resource_record_post_action 03:06:59 INFO - Running post-action listener: _start_resource_monitoring 03:06:59 INFO - Starting resource monitoring. 03:06:59 INFO - [mozharness: 2016-10-28 10:06:59.813585Z] Finished create-virtualenv step (success) 03:06:59 INFO - [mozharness: 2016-10-28 10:06:59.814512Z] Running install step. 03:06:59 INFO - Running pre-action listener: _resource_record_pre_action 03:06:59 INFO - Running main action method: install 03:06:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:00 INFO - Reading from file tmpfile_stdout 03:07:00 INFO - Detecting whether we're running mozinstall >=1.0... 03:07:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:07:00 INFO - Reading from file tmpfile_stdout 03:07:00 INFO - Output received: 03:07:00 INFO - Usage: mozinstall [options] installer 03:07:00 INFO - Options: 03:07:00 INFO - -h, --help show this help message and exit 03:07:00 INFO - -d DEST, --destination=DEST 03:07:00 INFO - Directory to install application into. [default: 03:07:00 INFO - "/builds/slave/test"] 03:07:00 INFO - --app=APP Application being installed. [default: firefox] 03:07:00 INFO - mkdir: /builds/slave/test/build/application 03:07:00 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'] 03:07:00 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 03:07:32 INFO - Reading from file tmpfile_stdout 03:07:32 INFO - Output received: 03:07:32 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:07:32 INFO - Running post-action listener: _resource_record_post_action 03:07:32 INFO - [mozharness: 2016-10-28 10:07:32.943022Z] Finished install step (success) 03:07:32 INFO - [mozharness: 2016-10-28 10:07:32.943179Z] Running run-tests step. 03:07:32 INFO - Running pre-action listener: _resource_record_pre_action 03:07:32 INFO - Running main action method: run_tests 03:07:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:07:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:07:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:07:32 INFO - 2016-10-28 03:07:32.957 screenresolution[1643:8276] starting screenresolution argv=screenresolution get 03:07:32 INFO - 2016-10-28 03:07:32.960 screenresolution[1643:8276] Display 0: 1600x1200x32@60 03:07:32 INFO - 2016-10-28 03:07:32.965 screenresolution[1644:8278] starting screenresolution argv=screenresolution list 03:07:32 INFO - Available Modes on Display 0 03:07:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:07:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:07:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:07:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:07:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:07:33 INFO - Intel Iris: 03:07:33 INFO - Chipset Model: Intel Iris 03:07:33 INFO - Type: GPU 03:07:33 INFO - Bus: Built-In 03:07:33 INFO - VRAM (Dynamic, Max): 1536 MB 03:07:33 INFO - Vendor: Intel (0x8086) 03:07:33 INFO - Device ID: 0x0a2e 03:07:33 INFO - Revision ID: 0x0009 03:07:33 INFO - Displays: 03:07:33 INFO - Display: 03:07:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:07:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:07:33 INFO - Display Serial Number: 1600x1200 60 03:07:33 INFO - Main Display: Yes 03:07:33 INFO - Mirror: Off 03:07:33 INFO - Online: Yes 03:07:33 INFO - Rotation: Supported 03:07:33 INFO - Return code: 0 03:07:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:07:33 INFO - Python 2.7.3 03:07:33 INFO - Return code: 0 03:07:33 INFO - grabbing minidump binary from tooltool 03:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:33 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 0x102c71d30>, '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 0x102ad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c69b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:07:33 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 03:07:33 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 03:07:33 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 03:07:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:07:33 INFO - Return code: 0 03:07:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:07:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:07:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:07:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:07:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:07:33 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/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 03:07:33 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/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --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 03:07:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3f6xzH47p/Render', 03:07:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:33 INFO - 'HOME': '/Users/cltbld', 03:07:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:33 INFO - 'LOGNAME': 'cltbld', 03:07:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:07:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:33 INFO - 'MOZ_NO_REMOTE': '1', 03:07:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:07:33 INFO - 'NO_EM_RESTART': '1', 03:07:33 INFO - 'PAGER': '/bin/cat', 03:07:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:33 INFO - 'PWD': '/builds/slave/test', 03:07:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:07:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:33 INFO - 'SHELL': '/bin/bash', 03:07:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rPzO29AAWY/Listeners', 03:07:33 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 03:07:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:33 INFO - 'USER': 'cltbld', 03:07:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:33 INFO - 'XPC_FLAGS': '0x0', 03:07:33 INFO - 'XPC_SERVICE_NAME': '0', 03:07:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:33 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/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 03:07:33 INFO - mozversion application_buildid: 20161028004017 03:07:33 INFO - mozversion application_changeset: 4af3cec722c07b291d41f6fd7ba727b17e2cb613 03:07:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:07:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:07:33 INFO - mozversion application_name: Firefox 03:07:33 INFO - mozversion application_remotingname: firefox-dev 03:07:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:07:33 INFO - mozversion application_vendor: Mozilla 03:07:33 INFO - mozversion application_version: 51.0a2 03:07:33 INFO - mozversion platform_buildid: 20161028004017 03:07:33 INFO - mozversion platform_changeset: 4af3cec722c07b291d41f6fd7ba727b17e2cb613 03:07:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:07:33 INFO - mozversion platform_version: 51.0a2 03:07:33 INFO - using testdate: 1477649253 03:07:33 INFO - actual date: 1477649253 03:07:33 INFO - starting webserver on 'localhost:49271' 03:07:33 INFO - SUITE-START | Running 2 tests 03:07:33 INFO - TEST-START | dromaeo_css 03:07:33 INFO - operating with platform_type : mac_ 03:07:33 INFO - Initialising browser for dromaeo_css test... 03:07:33 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp7021UM/profile http://localhost:49271/getInfo.html) 03:07:36 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 03:07:36 INFO - PROCESS | 1654 | colorDepth:24 03:07:36 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 03:07:36 INFO - PROCESS | 1654 | __metrics 03:07:36 INFO - PROCESS | 1654 | 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" 03:07:36 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:07:37 INFO - TEST-INFO | 1654: exit 0 03:07:37 INFO - Browser initialized. 03:07:37 INFO - Running cycle 1/1 for dromaeo_css test... 03:07:37 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp7021UM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:07:49 INFO - PROCESS | 1659 | RSS: Main: 220196864 03:07:49 INFO - PROCESS | 1659 | 03:08:40 INFO - PROCESS | 1659 | 1477649320111 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] 03:10:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 03:10:54 INFO - PROCESS | 1659 | RSS: Main: 371036160 03:10:54 INFO - PROCESS | 1659 | 03:13:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 03:13:58 INFO - PROCESS | 1659 | RSS: Main: 349818880 03:13:58 INFO - PROCESS | 1659 | 03:17:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 03:17:01 INFO - PROCESS | 1659 | RSS: Main: 327524352 03:17:01 INFO - PROCESS | 1659 | 03:20:03 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 03:20:04 INFO - PROCESS | 1659 | RSS: Main: 327024640 03:20:04 INFO - PROCESS | 1659 | 03:23:07 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 03:23:08 INFO - PROCESS | 1659 | RSS: Main: 314048512 03:23:08 INFO - PROCESS | 1659 | 03:26:11 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 03:26:11 INFO - PROCESS | 1659 | RSS: Main: 544407552 03:26:11 INFO - PROCESS | 1659 | 03:26:11 INFO - PROCESS | 1659 | __start_tp_report 03:26:11 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 03:26:11 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 03:26:11 INFO - PROCESS | 1659 | |i|pagename|runs| 03:26:11 INFO - PROCESS | 1659 | |0;dojo.html;3340.0480862954064;3382.661733826619;3397.286569820337;3418.8119653419085;3445.844936977836;5775.971120144399;5835.212246346752;5877.8824423511505;5881.117832325153;5925.200097986771;5772.624779389337;5802.187693722883;5823.737931793069;5824.534037277018;5837.24115864937;5278.419373868862;5292.655977361478;5341.973290133544;5346.893062138755;5375.623706340558;5254.973725131369;5275.630705850573;5398.757055932473;5401.621886467949;5409.540189083933;5286.920696189561;5342.198670199462;5348.652337598063;5348.732563371836;5358.624896257264;5332.946670533303;5353.197020446925;5354.3574771027725;5373.489518495776;5382.138857782775;5194.948050519522;5297.417284098746;5302.628815982883;5308.23030660552;5346.1713434417725;5889.823305300805;5892.440218179266;5893.79371721992;5896.528277737771;5897.026990546555;6209.472194863442;6226.128342032119;6285.748570057192;6295.8740825183695;6297.0554416837385;6254.687265636746;6263.71813268404;6299;6299.590526615755;6301.842453938642;5890.9410905891245;5895.616784908967;5913.822585322448;5918.23063001807;5969.850753731148;6229.190205273286;6254.6247225166635;6272.372762723691;6384;6410.711517981702;5093.159628661304;6175.228096487939;6254.562180647402;6316.810495685137;6321.905171422432;6308.400701933309;6319.778807741799;6327.651979141099;6331.68341582919;6332.461740751995;6106.225048349606;6169.537284703665;6332.525060620472;6335.176427064452;6348.523860710465;6185.8144255672405;6233.189685340877;6260.40526150015;6293.213348331458;6302.180716506825;4991.326170966873;4992.375953005874;4994.850154495371;4998.900021999612;5018.749062546931;4432.224360736858;4433.778311084433;4470.24005918988;4501.279795232747;4502.234620114588;5835.2122463466885;5893.057110862242;5906.616069955439;5960.761569537257;6003.5797494174985;6254.384786470203;6287.46556542699;6292.024736165901;6299.622022678654;6303.590266632654;5816.47651711348;5863.853403664943;5984.431479009487;5996.760129594854;6006.249218847644;5365.061114304981;5365.490278423544;5414;5447.073997420448;5499.587530935196;6423.325550817191;6473.093766872547;6474.902876456763;6479.31967143462;6491.318411566717;6232.25212974446;6277.686115694289;6279.591826531444;6281;6282.246130464374;5780.768769249183;5964.568503559028;6285.465735412358;6374.58565193261;6389.648569328546;6225.844353891189;6292.528060395397;6295.5907865988565;6314;6327.968360158354;6260.436560709558;6273.466755325849;6273.99616061428;6290.370962903856;6290.748370065146;6122.6938653068055;6162.876742465215;6192.287886892885;6227.657478838707;6283.088952102011;6145.801568694062;6200.627962322275;6208.534359922934;6284.748610055546;6288.591241569284;6114.357992410733;6127.3259941407305;6127.601705889103;6140.539459540463;6145.985912324595;6122.602030867979;6243.375662433902;6265.373462653698;6286.18279623646;6287.622742635456;6042.546808989431;6103.7253323601435;6116.174316467398;6142.385761423822;6202.844928876814 03:26:11 INFO - PROCESS | 1659 | |1;ext.html;449.12869034073896;528.1496790167829;535.2827211536543;535.9705216213107;537.827535971582;26171.869140654293;31730.524042139357;32631;32669.85655502058;32683.509747353808;42435.575644243545;43699.781501092526;43790.12419751603;45917.31124033142;46156.30765538511;9748.220142388593;9912.752181195456;9929.255305852053;9934.503274836265;9947.651832185875;8827.382083254175;9940.204783617293;10029.348092374008;10032.147267482236;10049.095581397673;8841.071687472819;12320.322382268972;12593.181443206162;12593.748125037493;12595.3072581008;12345.950594199503;12392.752144957096;12403.813942790865;12432.75134497305;12487.875121248762;8846.911530884674;9103.135202155785;12233.143679942408;12332.81500777489;12336.259824410474;40821.79589102065;41035.58964410348;41072;42937.570624293985;43018;3392.8982130536124;3430.468277417004;3703.166787472797;3938.3107956107565;4122.9381559276635;30621.540676889865;30630.846845765627;31738;31799.52300715468;33137.171570710685;3214.791038582485;3295.6869097435947;3332.683395077464;3397.96602033979;3437.5015622734563;461707;462033;462058.68970655266;464921;470309;53505.7324713374;53984.73007634937;61952.69023654943;61966;62716.37283627196;63327.68336158382;66932.665336673;66935.99192024246;67016.6649166751;67073;16199.676006479804;16437.93153445022;16449.25978330978;16453.91773041127;16539.25573349202;12498.25010499373;12642.873571264354;12655.620331390073;12664.923481504175;12669.683257918627;11240.426340312362;16028.75956860648;17664.381746639065;18066.638667226583;18120.728189077174;5607.915881261784;6478.514111441661;6563.081168636395;6614.834629134214;6616.966915165393;869.1742844297816;987.8715766950394;1010.6109147978082;1078.3907092492716;1113.0872684398878;29846.850765746032;30489.542656860165;30687.69312306893;30805.845970770002;31355.686443135277;969.5249327829313;1022.3814592171777;1048.8059708953867;1063.330102035728;1077.256692881909;12967.675808104872;15954.521364359089;15989.840101599068;16213.165517930182;16379.0172589645;690167;693939;694389;695150;696217;51274.48725512697;52172.69568260748;58582.70708646515;59574.702126489094;60061.798764024476;1350.2506109109343;1370.5682709946334;1394.9721005579831;1395.8185435893472;1397.6925076483158;30412.239694007825;31643.367132657677;32204.83897580497;32243.51634725434;32693.509597355584;46675;53607.6598085051;53757.46242537525;53786.731066344415;53862.46137538574;590136;860463;887986;889674;891327.1734565402;26089.95640174372;26359.736402635728;26377.944882205265;26383.736162638128;26487.735122648526;45740;46118.76940615275;46557;46955.295670565654;47037.059258815316;38316;38448.80775596104;38905.41641875318;39074.218515628956;39238.626648068326;38228;38759.6124038756;39168.6083139165;39882.80058599688;40165.79917100396;37565.43651845279;38298;38334;38648.80675596604;39285.2142957145;33793.81721639731;35296.11759705925;36143.81928090343;36260.63739362573;36557.90326290215;25930.481390372464;26432.471350572498;26449.471010580066;26654.333641658337;26973.921043158054 03:26:11 INFO - PROCESS | 1659 | |2;jquery.html;306.37652377411973;368.37928091166384;375.74824867338873;378.32657868993186;401.6545770637251;15213.695726085472;15595;16081.03513789172;20670;21006.264780732676;19941;20219.696704549442;20786.480337991557;20990.26534071308;21017.579648407023;4960.578350840165;5945.524358051367;6208.627482351051;6212.689365531728;6213.03697926822;5603.8599035024245;5765.4522820332;6150.354212807658;6168.84577885552;6170.197874276338;5785.103308987113;5991.161237426763;6140.754369825202;6150.784722534712;6157.415045570686;6057.636541807484;6093.664848433335;6117.632942023471;6122.357152498968;6123.2652081750475;5004.099262132815;5204.869878253036;5223.615741828418;5237.423883372826;5332.573394128461;25297.873510632515;25414.872925635253;25506.872465637553;25732.87133564339;26222.86888565564;2298;2345.3433038749176;2418.250342393846;2466.3420080649503;2910.63617047869;14816.851831481763;15402.921795474322;15424.68629705542;16616.418425355176;16664.083475408846;1801.4955812372557;1805.83523627261;1858.386732378312;1881.1440794438497;1958.4614231086566;120476.99999999913;120837.79162208353;124248;124555.3772231133;125022;9340.159385655188;9797.755056123653;10099;10189.369700847978;10377.9481102594;12473.563425280254;12588.433520491417;12596.307203103917;12601.495940162291;12616.17994830333;7883.84232315362;8136.75589732309;8137.226963438464;8204.671813127527;8223.54770487617;8306.252437280673;8379;8393.992720873533;8530.70142545008;8551.486910785372;3307.7595901536924;3924.7841368724994;3929.8035098245546;3930.1353702185475;4007.238624661305;1873.2914058648835;1935.3226370770399;1947.0946010105085;1952.687569988795;1960.784313725489;843.2537204573873;896.9819255145457;944.1596978688972;980.7842274699698;1013.1945103642622;21125.89437052805;21968;21972.450688732908;22061.779382206292;22143.335699929026;903.4579252448609;914.3188324698009;920.4707293306376;929.7257309093834;958.4584709639032;10979.83530247047;11398.943005285086;11406.030487408498;11457.506254587954;11618.88381116178;513224;514496;515494;621598;627969.8601506964;121922;128369.3581532105;129291.18189681487;131088;131515.3424232892;956.321012081416;1000.1598657127902;1014.2595904989399;1017.8371460566274;1017.9032991865761;17690.027048512457;18853.68024238345;18898;19685.21259149618;19721.21115155435;46300.53699462962;47285.05429891314;52659.73670131778;52761.47238527566;54784.45215547953;80637;81249;81492.59253703694;82343.7648435262;82682.58658706667;6883.483738719716;7280.526765760209;7833.412494063082;8050.6779728812535;8278.130796266547;11515.596954106566;12318.137730358789;12484.750304994031;12744.04419668547;12863.742725145257;8708.78228044304;9949.602015919281;10638.14894808429;10792.838107428237;10993.395363255098;10725;10857.891421085687;10894.498278369372;11386.544538218379;11395.430228488709;10698.786024279627;10743.24797264184;11214.887851121384;11249.49377278008;11401.885981140082;6947.68735406918;7285.890711639224;7300;7859.371250299848;8233.50598964064;10021.09810117093;10601.363918164934;10927.617533386294;10983.725406864893;10983.890161098287 03:26:11 INFO - PROCESS | 1659 | |3;mootools.html;1346.8720471555198;1485.873700735437;1524.2912045898656;1686.2159096020348;1845.7508236388092;7842.529448233103;8362.163783621634;8362.247397734203;8365.832683346336;8375.162483751621;8583.227509524157;8867.73396798097;8873.20141187293;9007.54962251888;9009.369344145913;2429.3440770991865;2461.05249478951;2461.1386014894824;2461.852288862665;2462.7167875694254;2390.3319081630116;2440.8779561021965;2444.584420648494;2445.7282213249186;2448.2165706973774;2420.5642984262827;2427.526632306701;2432.2338463383976;2451.742567030463;2455.742147074558;2339.3683705399617;2377.702787151606;2394.628832530952;2401.8318717689767;2411.1440438644204;2365.042157926043;2412.5054363855365;2412.9517409651885;2413.481101563155;2421.1767998880464;8835;9033.548322583845;9035.412698174663;9042.276617870555;9057.049009853936;5311.362636483608;5319.760610772524;5484.506394424521;5488.4237155098535;5492.5605951523785;3704;3763.2285381496727;3777.2823163599105;3790.8673196438267;3795.3358162321483;1090.5637744902024;1095.6274866545334;1124.7131981344787;1138.299945533499;1141.8401423800674;12035.638930832089;12128.57549985755;12134.939325303494;12138.514459421613;12148.392580371035;4383.824647014148;4556.0432309214775;4702.482726900038;4758.214894542431;4762.452317983476;9332.673356432493;9346.439213647203;9352.064793520729;9364.204042656314;9375.06249375057;5361.463853614685;5363.383210930715;5365.973170134124;5367.624266301322;5374.059539580558;4042.4542686737504;4413.117376524708;4818.855434336975;4826.734529600835;5043.722595257296;3336.9989003299397;3695.2240029594086;3728.254349130185;3820.7516511427225;3828.157805282833;1143.3140115930541;1180.9291442513477;1185.6561597136733;1191.642507247822;1193.3496244546743;812.6789917982364;904.2223687628634;912.9224015958586;933.7012156109979;959.491469521141;5705.771769129271;5900.970495147497;6003.189569408161;6068.6358818471035;6198.101275315054;438.56362918895906;439.7427504909664;440.77025099970723;457.1953362082758;457.76425141052385;3911.3350730375337;3930.508686414198;3962.405639154092;3980.283548961215;4021.8190181441905;9355.251579873593;10685.412302323446;11121.388323642277;11148.331100134017;11159.944200278947;9787.951060244795;10723.89276107229;10931.781364372668;11088.944555277172;11101.1674124441;7971.242731940456;8213.301869341054;8241.752747417468;8428.283595894294;8433.704820331259;5919.940800591939;5976.8804623908145;6050.84872878164;6053.182820319201;6085.6348619083;9956.751081223027;9995.70012899614;10141.797164056825;10234.6417875374;10300.124489418484;8619.525926074126;10402.791944161227;10489.265751397328;10514.789704206027;10653;6883.586984780929;7058.294170582901;7521;7546.773596792105;7717.382609391348;8468.618912149092;8660.220580147818;8667.133286671282;8669.869951950852;8674.175953284428;6866.965665171642;7481.989931359197;7566.848663026599;7718.3053525183;7830.3735701144915;7367.77896663101;7521.736739214321;7590.051243594551;7622.961885190539;7689.231076892266;6921.134858142732;7068.399186069241;7075.150981882207;7084.752033678797;7097.574145551283;4832.63755218353;4862.3922009748785;4899;5005.174146265826;5061.493850614909;4968.503149685002;5004.2493625956395;5060.342155519759;5132.692038477703;5183.455737147545 03:26:11 INFO - PROCESS | 1659 | |4;prototype.html;296.3495128193615;299.31307648945665;304.42463743524735;309.41983780411726;311.7396973527105;4321.049369138792;4421.977890110549;5131.61114412556;5133.974330128344;5351.331083614548;4129.7522148671105;4335.241332766769;4475.843345482909;5223.738813059351;5259.474052594738;4067;4076.388541718751;4079.4090304781157;4081.6122468365534;4090.6727461802984;3577.7656708435547;3772.4152756322815;3920.353141731611;4080.2047099276224;4105.589441055886;3326.7837590556537;4011.1576568920564;4011.699122565805;4043.939340909889;4055.837766489337;3996.2407142642805;4003.7597744135446;4022.416749571325;4034.576369481221;4043.5147782266167;3099.7210251077513;3460.0657822387816;3460.7058400036026;3477.4088404971217;3518.4546395308766;4097.97951010246;4559.544045595447;4574.324020448042;4595.448546174447;4801.495842936476;4402;4556.111558246143;4576.405067341224;4585.5009020084135;4597.37935378723;4852.393450818648;4944.21767347979;5279.313689220377;5527.585431092684;5553.916691249635;3167.509036099408;3629.8565951725386;3708.0173753955223;3836.290286297044;3973.662238709684;4806.927896081562;5815.389384114649;5843.983825580168;5866.6480011199465;5933.317668468138;3255.951160732591;3827.9043023924623;3832.846686132579;3834.9233015339537;3839.308924393636;3115.8753649854207;3257.2345498807763;3582.731295152874;3899.902502437462;3935.8032098394965;4360.4331436913;4380.956190438055;4504.774761261924;4569.771511424416;4606.424196975378;4606.792694328763;4660.97669511657;5569.359523654832;5615.578831587647;5659.349174844946;986.5264672957021;1261.564760157744;1281.39774306076;1290.5160564788205;1300.6878349196313;809.3848675007036;846.272205902923;872.7076429396096;877.5875338590852;893.65147592439;4435.846679863194;5128.922926185468;5274.525292723673;5288.629795914326;5323;4292.462723087245;4693.404242557479;4735.12400205963;5530.2810634618045;5715.371309155989;4220.409142720022;4387.714798538085;5144.742762861842;5224.033553792485;5242.9213561796605;2122.898330652643;2252.9636367271237;2308.9653655195184;2502.94994100117;2516.5973444248834;4445.555444455528;4879.268109783561;4885.951140488621;4968.826091086795;5535.778568857281;4559.534753587298;6019.4883434908525;6022.247219097613;6042.791441711675;6059.36376680451;5280.471952804765;5877.882442351129;6063.181470501426;6068.33248342682;6077.6353418795015;4835.540623640749;5401.6218864679095;5504.587155963239;5825.854353641193;5844.357120716632;4791.448983366958;4900.387451568554;5782.826515204551;5796.855078623068;5813;5552.583556233218;5714.314277288293;6050.273967123973;6050.364711705383;6095.634261944298;3497.527833742412;3709.5919448860063;3823.5411750590106;3848.615138486129;3944.6252606002386;5303.310569625924;5796.362400135898;5807.912881306868;5811.506021988178;5836.299644042742;5452.945470545244;5710.086386178192;5714.714264286852;5755.453231942959;5771.422857714195;5666.603337766317;5676.772929082956;5706.201131841629;5710.5717071219;5714.485696287354;4768.928466072943;5233.973830130825;5252.921206181987;5389.51494365509;5555.805546805843;4769.880752981203;5536.584756143386;5643.492085712305;5682.744276507649;5804.448577385142;4381.802818873095;5245.842624721265;5260.868478288074;5556.666600004012;5557.555395568425 03:26:11 INFO - PROCESS | 1659 | |5;yui.html;648.500654496038;681.7545683553919;706.2196273118205;776.8873513340566;783.4711569690464;11850.940745296271;15116.848831511681;15185.848141518596;15217.239138043094;16651.583710407245;14745.48390806322;15139.62150946227;15149.545513634608;15159.92420037901;15210.543683689479;652.693234179937;672.294091204236;676.898465230217;810.226233946581;828.5732847583499;750.7334896111884;817.9795505112361;839.9244068033876;847.8215280759749;850.9958249265864;883.9646414143426;886.9689560865371;887.2059506741494;887.9378443508957;887.995560022199;693.729445516249;715.3740477082553;883.5052370672444;883.9116088391141;886.9246114080246;626.0984182776787;643.279526929837;648.7275344355382;650.3334082565408;650.6779144323543;15020.17389043602;15036.548903532912;15044.323005464781;15064.246787660682;15069.472568460162;13966.860331396658;14205.573832785032;14217.289135543182;14405.567832965027;14415.855841441557;12695.93652031734;12911.327066437745;12965;13136.408861601156;13530.86469135306;4441.333799930037;4454.688171827974;4541.046380260149;4546.681732278742;4620.260758278693;113218.43390783075;116923;117062;117475.41262293719;117775.41112294384;10331.845022324671;10940.343579385262;10972.286801358046;11141.944290278496;11182.32906025641;20764.896175519327;21250.25624103149;21275;21299.148034078462;21329.78670213309;7399.7410090647645;7597.5821329826285;7679.040119985002;7871.0948240951875;7918.287354138155;4295.2096495121095;4394.560543945579;4419.248727716296;4462.3752674625575;4581.083783243364;3478.617352091268;3485.233248685285;3487.9651203488147;3519.454484554898;3598.5501812273465;633.3476519185247;634.1375729008545;640.7340953504244;640.9006603976391;641.7978336823885;538.7548665357332;568.0286709726331;624.2415465209701;650.9357200976438;667.1926968368232;7885.960570197227;8946.463212207289;9045.954770226106;9205.309601779893;9238.953805231065;588.4733163818444;628.1237673445518;629.8427884495676;644.1786721929484;647.8542327976262;3887.319719049155;4028.939565906514;4436.844710435119;4439.289713645801;4440.600345968814;118491;120171.39914300373;122285;129504;163858;116183;116535.41732291284;117923;118252;122013.38993304977;75606.62196688981;96499;107598;108031;110830.44584777186;9661.937186909576;9719.9028009719;9765.755856103655;9933;10078.748031298983;50717;50920;64696.35303646903;65406;65929.67035164793;61871;64388.67805660942;74122;87582.68625970744;87807.12192877989;11534.711632209262;13901.860981390057;13926.1079838265;14060.718785624435;14338.856611433752;11965.700857478632;14626.561203163923;14789.704205916036;14885.553433397015;14911.403543858125;13062;13314.733705326033;13489.595312140651;13770.036097473481;14319;12886.935565322114;13312.667183320495;14296;14722.969392142448;14751.557453276419;12934.417951192407;14112.435502580192;14305;14311.928440357731;14319.35562899693;10016.699499015042;11150.721231969266;11529;11854.288742675468;12090.395480226129;8186.672533098609;9889.554251269185;11561.595344162914;11767.52929882795;11821.349825759666 03:26:11 INFO - PROCESS | 1659 | __end_tp_report 03:26:11 INFO - PROCESS | 1659 | __start_cc_report 03:26:11 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1320 03:26:11 INFO - PROCESS | 1659 | __end_cc_report 03:26:11 INFO - PROCESS | 1659 | __startTimestamp1477650371520__endTimestamp 03:26:11 INFO - PROCESS | 1659 | 03:26:11 INFO - PROCESS | 1659 | ------- Summary: start ------- 03:26:11 INFO - PROCESS | 1659 | Number of tests: 6 03:26:11 INFO - PROCESS | 1659 | 03:26:11 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5838.72 Median:6116.17 stddev:641.35 (10.5%) stddev-sans-first:612.63 03:26:11 INFO - PROCESS | 1659 | Values: 3340.0 3382.7 3397.3 3418.8 3445.8 5776.0 5835.2 5877.9 5881.1 5925.2 5772.6 5802.2 5823.7 5824.5 5837.2 5278.4 5292.7 5342.0 5346.9 5375.6 5255.0 5275.6 5398.8 5401.6 5409.5 5286.9 5342.2 5348.7 5348.7 5358.6 5332.9 5353.2 5354.4 5373.5 5382.1 5194.9 5297.4 5302.6 5308.2 5346.2 5889.8 5892.4 5893.8 5896.5 5897.0 6209.5 6226.1 6285.7 6295.9 6297.1 6254.7 6263.7 6299.0 6299.6 6301.8 5890.9 5895.6 5913.8 5918.2 5969.9 6229.2 6254.6 6272.4 6384.0 6410.7 5093.2 6175.2 6254.6 6316.8 6321.9 6308.4 6319.8 6327.7 6331.7 6332.5 6106.2 6169.5 6332.5 6335.2 6348.5 6185.8 6233.2 6260.4 6293.2 6302.2 4991.3 4992.4 4994.9 4998.9 5018.7 4432.2 4433.8 4470.2 4501.3 4502.2 5835.2 5893.1 5906.6 5960.8 6003.6 6254.4 6287.5 6292.0 6299.6 6303.6 5816.5 5863.9 5984.4 5996.8 6006.2 5365.1 5365.5 5414.0 5447.1 5499.6 6423.3 6473.1 6474.9 6479.3 6491.3 6232.3 6277.7 6279.6 6281.0 6282.2 5780.8 5964.6 6285.5 6374.6 6389.6 6225.8 6292.5 6295.6 6314.0 6328.0 6260.4 6273.5 6274.0 6290.4 6290.7 6122.7 6162.9 6192.3 6227.7 6283.1 6145.8 6200.6 6208.5 6284.7 6288.6 6114.4 6127.3 6127.6 6140.5 6146.0 6122.6 6243.4 6265.4 6286.2 6287.6 6042.5 6103.7 6116.2 6142.4 6202.8 03:26:11 INFO - PROCESS | 1659 | 03:26:11 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:78100.97 Median:37896.72 stddev:183279.10 (483.6%) stddev-sans-first:183700.51 03:26:11 INFO - PROCESS | 1659 | Values: 449.1 528.1 535.3 536.0 537.8 26171.9 31730.5 32631.0 32669.9 32683.5 42435.6 43699.8 43790.1 45917.3 46156.3 9748.2 9912.8 9929.3 9934.5 9947.7 8827.4 9940.2 10029.3 10032.1 10049.1 8841.1 12320.3 12593.2 12593.7 12595.3 12346.0 12392.8 12403.8 12432.8 12487.9 8846.9 9103.1 12233.1 12332.8 12336.3 40821.8 41035.6 41072.0 42937.6 43018.0 3392.9 3430.5 3703.2 3938.3 4122.9 30621.5 30630.8 31738.0 31799.5 33137.2 3214.8 3295.7 3332.7 3398.0 3437.5 461707.0 462033.0 462058.7 464921.0 470309.0 53505.7 53984.7 61952.7 61966.0 62716.4 63327.7 66932.7 66936.0 67016.7 67073.0 16199.7 16437.9 16449.3 16453.9 16539.3 12498.3 12642.9 12655.6 12664.9 12669.7 11240.4 16028.8 17664.4 18066.6 18120.7 5607.9 6478.5 6563.1 6614.8 6617.0 869.2 987.9 1010.6 1078.4 1113.1 29846.9 30489.5 30687.7 30805.8 31355.7 969.5 1022.4 1048.8 1063.3 1077.3 12967.7 15954.5 15989.8 16213.2 16379.0 690167.0 693939.0 694389.0 695150.0 696217.0 51274.5 52172.7 58582.7 59574.7 60061.8 1350.3 1370.6 1395.0 1395.8 1397.7 30412.2 31643.4 32204.8 32243.5 32693.5 46675.0 53607.7 53757.5 53786.7 53862.5 590136.0 860463.0 887986.0 889674.0 891327.2 26090.0 26359.7 26377.9 26383.7 26487.7 45740.0 46118.8 46557.0 46955.3 47037.1 38316.0 38448.8 38905.4 39074.2 39238.6 38228.0 38759.6 39168.6 39882.8 40165.8 37565.4 38298.0 38334.0 38648.8 39285.2 33793.8 35296.1 36143.8 36260.6 36557.9 25930.5 26432.5 26449.5 26654.3 26973.9 03:26:11 INFO - PROCESS | 1659 | 03:26:11 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34073.21 Median:25356.37 stddev:94244.46 (371.7%) stddev-sans-first:94474.73 03:26:11 INFO - PROCESS | 1659 | Values: 306.4 368.4 375.7 378.3 401.7 15213.7 15595.0 16081.0 20670.0 21006.3 19941.0 20219.7 20786.5 20990.3 21017.6 4960.6 5945.5 6208.6 6212.7 6213.0 5603.9 5765.5 6150.4 6168.8 6170.2 5785.1 5991.2 6140.8 6150.8 6157.4 6057.6 6093.7 6117.6 6122.4 6123.3 5004.1 5204.9 5223.6 5237.4 5332.6 25297.9 25414.9 25506.9 25732.9 26222.9 2298.0 2345.3 2418.3 2466.3 2910.6 14816.9 15402.9 15424.7 16616.4 16664.1 1801.5 1805.8 1858.4 1881.1 1958.5 120477.0 120837.8 124248.0 124555.4 125022.0 9340.2 9797.8 10099.0 10189.4 10377.9 12473.6 12588.4 12596.3 12601.5 12616.2 7883.8 8136.8 8137.2 8204.7 8223.5 8306.3 8379.0 8394.0 8530.7 8551.5 3307.8 3924.8 3929.8 3930.1 4007.2 1873.3 1935.3 1947.1 1952.7 1960.8 843.3 897.0 944.2 980.8 1013.2 21125.9 21968.0 21972.5 22061.8 22143.3 903.5 914.3 920.5 929.7 958.5 10979.8 11398.9 11406.0 11457.5 11618.9 513224.0 514496.0 515494.0 621598.0 627969.9 121922.0 128369.4 129291.2 131088.0 131515.3 956.3 1000.2 1014.3 1017.8 1017.9 17690.0 18853.7 18898.0 19685.2 19721.2 46300.5 47285.1 52659.7 52761.5 54784.5 80637.0 81249.0 81492.6 82343.8 82682.6 6883.5 7280.5 7833.4 8050.7 8278.1 11515.6 12318.1 12484.8 12744.0 12863.7 8708.8 9949.6 10638.1 10792.8 10993.4 10725.0 10857.9 10894.5 11386.5 11395.4 10698.8 10743.2 11214.9 11249.5 11401.9 6947.7 7285.9 7300.0 7859.4 8233.5 10021.1 10601.4 10927.6 10983.7 10983.9 03:26:11 INFO - PROCESS | 1659 | 03:26:11 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5733.62 Median:4880.70 stddev:3244.59 (66.5%) stddev-sans-first:3236.94 03:26:11 INFO - PROCESS | 1659 | Values: 1346.9 1485.9 1524.3 1686.2 1845.8 7842.5 8362.2 8362.2 8365.8 8375.2 8583.2 8867.7 8873.2 9007.5 9009.4 2429.3 2461.1 2461.1 2461.9 2462.7 2390.3 2440.9 2444.6 2445.7 2448.2 2420.6 2427.5 2432.2 2451.7 2455.7 2339.4 2377.7 2394.6 2401.8 2411.1 2365.0 2412.5 2413.0 2413.5 2421.2 8835.0 9033.5 9035.4 9042.3 9057.0 5311.4 5319.8 5484.5 5488.4 5492.6 3704.0 3763.2 3777.3 3790.9 3795.3 1090.6 1095.6 1124.7 1138.3 1141.8 12035.6 12128.6 12134.9 12138.5 12148.4 4383.8 4556.0 4702.5 4758.2 4762.5 9332.7 9346.4 9352.1 9364.2 9375.1 5361.5 5363.4 5366.0 5367.6 5374.1 4042.5 4413.1 4818.9 4826.7 5043.7 3337.0 3695.2 3728.3 3820.8 3828.2 1143.3 1180.9 1185.7 1191.6 1193.3 812.7 904.2 912.9 933.7 959.5 5705.8 5901.0 6003.2 6068.6 6198.1 438.6 439.7 440.8 457.2 457.8 3911.3 3930.5 3962.4 3980.3 4021.8 9355.3 10685.4 11121.4 11148.3 11159.9 9788.0 10723.9 10931.8 11088.9 11101.2 7971.2 8213.3 8241.8 8428.3 8433.7 5919.9 5976.9 6050.8 6053.2 6085.6 9956.8 9995.7 10141.8 10234.6 10300.1 8619.5 10402.8 10489.3 10514.8 10653.0 6883.6 7058.3 7521.0 7546.8 7717.4 8468.6 8660.2 8667.1 8669.9 8674.2 6867.0 7482.0 7566.8 7718.3 7830.4 7367.8 7521.7 7590.1 7623.0 7689.2 6921.1 7068.4 7075.2 7084.8 7097.6 4832.6 4862.4 4899.0 5005.2 5061.5 4968.5 5004.2 5060.3 5132.7 5183.5 03:26:11 INFO - PROCESS | 1659 | 03:26:11 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4422.96 Median:4780.66 stddev:1413.04 (29.6%) stddev-sans-first:1382.64 03:26:11 INFO - PROCESS | 1659 | Values: 296.3 299.3 304.4 309.4 311.7 4321.0 4422.0 5131.6 5134.0 5351.3 4129.8 4335.2 4475.8 5223.7 5259.5 4067.0 4076.4 4079.4 4081.6 4090.7 3577.8 3772.4 3920.4 4080.2 4105.6 3326.8 4011.2 4011.7 4043.9 4055.8 3996.2 4003.8 4022.4 4034.6 4043.5 3099.7 3460.1 3460.7 3477.4 3518.5 4098.0 4559.5 4574.3 4595.4 4801.5 4402.0 4556.1 4576.4 4585.5 4597.4 4852.4 4944.2 5279.3 5527.6 5553.9 3167.5 3629.9 3708.0 3836.3 3973.7 4806.9 5815.4 5844.0 5866.6 5933.3 3256.0 3827.9 3832.8 3834.9 3839.3 3115.9 3257.2 3582.7 3899.9 3935.8 4360.4 4381.0 4504.8 4569.8 4606.4 4606.8 4661.0 5569.4 5615.6 5659.3 986.5 1261.6 1281.4 1290.5 1300.7 809.4 846.3 872.7 877.6 893.7 4435.8 5128.9 5274.5 5288.6 5323.0 4292.5 4693.4 4735.1 5530.3 5715.4 4220.4 4387.7 5144.7 5224.0 5242.9 2122.9 2253.0 2309.0 2502.9 2516.6 4445.6 4879.3 4886.0 4968.8 5535.8 4559.5 6019.5 6022.2 6042.8 6059.4 5280.5 5877.9 6063.2 6068.3 6077.6 4835.5 5401.6 5504.6 5825.9 5844.4 4791.4 4900.4 5782.8 5796.9 5813.0 5552.6 5714.3 6050.3 6050.4 6095.6 3497.5 3709.6 3823.5 3848.6 3944.6 5303.3 5796.4 5807.9 5811.5 5836.3 5452.9 5710.1 5714.7 5755.5 5771.4 5666.6 5676.8 5706.2 5710.6 5714.5 4768.9 5234.0 5252.9 5389.5 5555.8 4769.9 5536.6 5643.5 5682.7 5804.4 4381.8 5245.8 5260.9 5556.7 5557.6 03:26:11 INFO - PROCESS | 1659 | 03:26:11 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:23477.45 Median:3559.00 stddev:36512.12 (1025.9%) stddev-sans-first:36574.31 03:26:11 INFO - PROCESS | 1659 | Values: 648.5 681.8 706.2 776.9 783.5 11850.9 15116.8 15185.8 15217.2 16651.6 14745.5 15139.6 15149.5 15159.9 15210.5 652.7 672.3 676.9 810.2 828.6 750.7 818.0 839.9 847.8 851.0 884.0 887.0 887.2 887.9 888.0 693.7 715.4 883.5 883.9 886.9 626.1 643.3 648.7 650.3 650.7 15020.2 15036.5 15044.3 15064.2 15069.5 13966.9 14205.6 14217.3 14405.6 14415.9 12695.9 12911.3 12965.0 13136.4 13530.9 4441.3 4454.7 4541.0 4546.7 4620.3 113218.4 116923.0 117062.0 117475.4 117775.4 10331.8 10940.3 10972.3 11141.9 11182.3 20764.9 21250.3 21275.0 21299.1 21329.8 7399.7 7597.6 7679.0 7871.1 7918.3 4295.2 4394.6 4419.2 4462.4 4581.1 3478.6 3485.2 3488.0 3519.5 3598.6 633.3 634.1 640.7 640.9 641.8 538.8 568.0 624.2 650.9 667.2 7886.0 8946.5 9046.0 9205.3 9239.0 588.5 628.1 629.8 644.2 647.9 3887.3 4028.9 4436.8 4439.3 4440.6 118491.0 120171.4 122285.0 129504.0 163858.0 116183.0 116535.4 117923.0 118252.0 122013.4 75606.6 96499.0 107598.0 108031.0 110830.4 9661.9 9719.9 9765.8 9933.0 10078.7 50717.0 50920.0 64696.4 65406.0 65929.7 61871.0 64388.7 74122.0 87582.7 87807.1 11534.7 13901.9 13926.1 14060.7 14338.9 11965.7 14626.6 14789.7 14885.6 14911.4 13062.0 13314.7 13489.6 13770.0 14319.0 12886.9 13312.7 14296.0 14723.0 14751.6 12934.4 14112.4 14305.0 14311.9 14319.4 10016.7 11150.7 11529.0 11854.3 12090.4 8186.7 9889.6 11561.6 11767.5 11821.3 03:26:11 INFO - PROCESS | 1659 | -------- Summary: end -------- 03:26:11 INFO - PROCESS | 1659 | 03:26:12 INFO - TEST-INFO | 1659: exit 0 03:26:12 INFO - TEST-OK | dromaeo_css | took 1118594ms 03:26:12 INFO - TEST-START | kraken 03:26:12 INFO - operating with platform_type : mac_ 03:26:12 INFO - Initialising browser for kraken test... 03:26:12 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp1ZoIG1/profile http://localhost:49271/getInfo.html) 03:26:14 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 03:26:14 INFO - PROCESS | 1665 | colorDepth:24 03:26:14 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 03:26:14 INFO - PROCESS | 1665 | __metrics 03:26:14 INFO - PROCESS | 1665 | 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" 03:26:14 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:26:15 INFO - TEST-INFO | 1665: exit 0 03:26:15 INFO - Browser initialized. 03:26:15 INFO - Running cycle 1/1 for kraken test... 03:26:15 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp1ZoIG1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:27 INFO - PROCESS | 1667 | RSS: Main: 219791360 03:26:27 INFO - PROCESS | 1667 | 03:26:30 INFO - PROCESS | 1667 | 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) 03:26:31 INFO - PROCESS | 1667 | RSS: Main: 270139392 03:26:31 INFO - PROCESS | 1667 | 03:26:33 INFO - PROCESS | 1667 | 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) 03:26:34 INFO - PROCESS | 1667 | RSS: Main: 280428544 03:26:34 INFO - PROCESS | 1667 | 03:26:37 INFO - PROCESS | 1667 | 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) 03:26:38 INFO - PROCESS | 1667 | RSS: Main: 378159104 03:26:38 INFO - PROCESS | 1667 | 03:26:40 INFO - PROCESS | 1667 | 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) 03:26:40 INFO - PROCESS | 1667 | RSS: Main: 280723456 03:26:40 INFO - PROCESS | 1667 | 03:26:42 INFO - PROCESS | 1667 | 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) 03:26:43 INFO - PROCESS | 1667 | RSS: Main: 281292800 03:26:43 INFO - PROCESS | 1667 | 03:26:46 INFO - PROCESS | 1667 | 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) 03:26:46 INFO - PROCESS | 1667 | RSS: Main: 317362176 03:26:46 INFO - PROCESS | 1667 | 03:26:49 INFO - PROCESS | 1667 | 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) 03:26:50 INFO - PROCESS | 1667 | RSS: Main: 320294912 03:26:50 INFO - PROCESS | 1667 | 03:26:53 INFO - PROCESS | 1667 | 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) 03:26:53 INFO - PROCESS | 1667 | RSS: Main: 316973056 03:26:53 INFO - PROCESS | 1667 | 03:26:55 INFO - PROCESS | 1667 | 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) 03:26:55 INFO - PROCESS | 1667 | RSS: Main: 291258368 03:26:55 INFO - PROCESS | 1667 | 03:26:57 INFO - PROCESS | 1667 | 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) 03:26:58 INFO - PROCESS | 1667 | RSS: Main: 295428096 03:26:58 INFO - PROCESS | 1667 | 03:27:00 INFO - PROCESS | 1667 | 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) 03:27:01 INFO - PROCESS | 1667 | RSS: Main: 301289472 03:27:01 INFO - PROCESS | 1667 | 03:27:04 INFO - PROCESS | 1667 | 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) 03:27:04 INFO - PROCESS | 1667 | RSS: Main: 309530624 03:27:04 INFO - PROCESS | 1667 | 03:27:07 INFO - PROCESS | 1667 | 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) 03:27:08 INFO - PROCESS | 1667 | RSS: Main: 308887552 03:27:08 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | 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) 03:27:10 INFO - PROCESS | 1667 | RSS: Main: 353112064 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | __start_tp_report 03:27:10 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 03:27:10 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 03:27:10 INFO - PROCESS | 1667 | |i|pagename|runs| 03:27:10 INFO - PROCESS | 1667 | |0;ai-astar;116;114;112;114;114;114;114;114;113;114 03:27:10 INFO - PROCESS | 1667 | |1;audio-beat-detection;145;109;108;150;138;139;127;106;138;108 03:27:10 INFO - PROCESS | 1667 | |2;audio-dft;185;181;191;257;179;180;182;186;184;181 03:27:10 INFO - PROCESS | 1667 | |3;audio-fft;79;59;60;87;60;59;59;57;91;82 03:27:10 INFO - PROCESS | 1667 | |4;audio-oscillator;89;71;94;69;68;68;92;68;69;112 03:27:10 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;90;87;90;88;91;87;91;88;90;87 03:27:10 INFO - PROCESS | 1667 | |6;imaging-darkroom;96;95;96;97;95;96;96;96;96;95 03:27:10 INFO - PROCESS | 1667 | |7;imaging-desaturate;86;84;87;83;86;83;86;86;84;81 03:27:10 INFO - PROCESS | 1667 | |8;json-parse-financial;57;52;52;53;57;57;57;56;57;56 03:27:10 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;64;75;74;71;69;68;70;68;68;70 03:27:10 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;93;102;105;105;83;86;81;85;86;88 03:27:10 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;140;136;138;137;137;140;144;139;169;126 03:27:10 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;168;164;162;162;164;163;170;175;148;225 03:27:10 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;67;67;68;81;85;86;81;66;66;66 03:27:10 INFO - PROCESS | 1667 | __end_tp_report 03:27:10 INFO - PROCESS | 1667 | __start_cc_report 03:27:10 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,2036 03:27:10 INFO - PROCESS | 1667 | __end_cc_report 03:27:10 INFO - PROCESS | 1667 | __startTimestamp1477650430569__endTimestamp 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | ------- Summary: start ------- 03:27:10 INFO - PROCESS | 1667 | Number of tests: 14 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.99 (0.9%) stddev-sans-first:0.71 03:27:10 INFO - PROCESS | 1667 | Values: 116.0 114.0 112.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:138.00 stddev:17.40 (12.6%) stddev-sans-first:17.17 03:27:10 INFO - PROCESS | 1667 | Values: 145.0 109.0 108.0 150.0 138.0 139.0 127.0 106.0 138.0 108.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:190.60 Median:184.50 stddev:23.59 (12.8%) stddev-sans-first:24.94 03:27:10 INFO - PROCESS | 1667 | Values: 185.0 181.0 191.0 257.0 179.0 180.0 182.0 186.0 184.0 181.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:69.30 Median:69.50 stddev:13.67 (19.7%) stddev-sans-first:14.04 03:27:10 INFO - PROCESS | 1667 | Values: 79.0 59.0 60.0 87.0 60.0 59.0 59.0 57.0 91.0 82.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:70.00 stddev:15.63 (22.3%) stddev-sans-first:16.24 03:27:10 INFO - PROCESS | 1667 | Values: 89.0 71.0 94.0 69.0 68.0 68.0 92.0 68.0 69.0 112.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:88.90 Median:90.00 stddev:1.66 (1.8%) stddev-sans-first:1.72 03:27:10 INFO - PROCESS | 1667 | Values: 90.0 87.0 90.0 88.0 91.0 87.0 91.0 88.0 90.0 87.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:27:10 INFO - PROCESS | 1667 | Values: 96.0 95.0 96.0 97.0 95.0 96.0 96.0 96.0 96.0 95.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:86.00 stddev:1.90 (2.2%) stddev-sans-first:1.94 03:27:10 INFO - PROCESS | 1667 | Values: 86.0 84.0 87.0 83.0 86.0 83.0 86.0 86.0 84.0 81.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:57.00 stddev:2.17 (3.8%) stddev-sans-first:2.22 03:27:10 INFO - PROCESS | 1667 | Values: 57.0 52.0 52.0 53.0 57.0 57.0 57.0 56.0 57.0 56.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:3.16 (4.5%) stddev-sans-first:2.60 03:27:10 INFO - PROCESS | 1667 | Values: 64.0 75.0 74.0 71.0 69.0 68.0 70.0 68.0 68.0 70.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:85.50 stddev:9.28 (10.8%) stddev-sans-first:9.82 03:27:10 INFO - PROCESS | 1667 | Values: 93.0 102.0 105.0 105.0 83.0 86.0 81.0 85.0 86.0 88.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:139.50 stddev:11.00 (7.9%) stddev-sans-first:11.66 03:27:10 INFO - PROCESS | 1667 | Values: 140.0 136.0 138.0 137.0 137.0 140.0 144.0 139.0 169.0 126.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:166.00 stddev:20.51 (12.4%) stddev-sans-first:21.74 03:27:10 INFO - PROCESS | 1667 | Values: 168.0 164.0 162.0 162.0 164.0 163.0 170.0 175.0 148.0 225.0 03:27:10 INFO - PROCESS | 1667 | 03:27:10 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:74.50 stddev:8.72 (11.7%) stddev-sans-first:8.94 03:27:10 INFO - PROCESS | 1667 | Values: 67.0 67.0 68.0 81.0 85.0 86.0 81.0 66.0 66.0 66.0 03:27:10 INFO - PROCESS | 1667 | -------- Summary: end -------- 03:27:10 INFO - PROCESS | 1667 | 03:27:11 INFO - TEST-INFO | 1667: exit 0 03:27:11 INFO - TEST-OK | kraken | took 59272ms 03:27:11 INFO - SUITE-END | took 1177s 03:27:11 INFO - Completed test suite (00:19:38) 03:27:11 INFO - javascript benchmark 03:27:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3340.0480862954064, 3382.661733826619, 3397.286569820337, 3418.8119653419085, 3445.844936977836, 5775.971120144399, 5835.212246346752, 5877.8824423511505, 5881.117832325153, 5925.200097986771, 5772.624779389337, 5802.187693722883, 5823.737931793069, 5824.534037277018, 5837.24115864937, 5278.419373868862, 5292.655977361478, 5341.973290133544, 5346.893062138755, 5375.623706340558, 5254.973725131369, 5275.630705850573, 5398.757055932473, 5401.621886467949, 5409.540189083933, 5286.920696189561, 5342.198670199462, 5348.652337598063, 5348.732563371836, 5358.624896257264, 5332.946670533303, 5353.197020446925, 5354.3574771027725, 5373.489518495776, 5382.138857782775, 5194.948050519522, 5297.417284098746, 5302.628815982883, 5308.23030660552, 5346.1713434417725, 5889.823305300805, 5892.440218179266, 5893.79371721992, 5896.528277737771, 5897.026990546555, 6209.472194863442, 6226.128342032119, 6285.748570057192, 6295.8740825183695, 6297.0554416837385, 6254.687265636746, 6263.71813268404, 6299.0, 6299.590526615755, 6301.842453938642, 5890.9410905891245, 5895.616784908967, 5913.822585322448, 5918.23063001807, 5969.850753731148, 6229.190205273286, 6254.6247225166635, 6272.372762723691, 6384.0, 6410.711517981702, 5093.159628661304, 6175.228096487939, 6254.562180647402, 6316.810495685137, 6321.905171422432, 6308.400701933309, 6319.778807741799, 6327.651979141099, 6331.68341582919, 6332.461740751995, 6106.225048349606, 6169.537284703665, 6332.525060620472, 6335.176427064452, 6348.523860710465, 6185.8144255672405, 6233.189685340877, 6260.40526150015, 6293.213348331458, 6302.180716506825, 4991.326170966873, 4992.375953005874, 4994.850154495371, 4998.900021999612, 5018.749062546931, 4432.224360736858, 4433.778311084433, 4470.24005918988, 4501.279795232747, 4502.234620114588, 5835.2122463466885, 5893.057110862242, 5906.616069955439, 5960.761569537257, 6003.5797494174985, 6254.384786470203, 6287.46556542699, 6292.024736165901, 6299.622022678654, 6303.590266632654, 5816.47651711348, 5863.853403664943, 5984.431479009487, 5996.760129594854, 6006.249218847644, 5365.061114304981, 5365.490278423544, 5414.0, 5447.073997420448, 5499.587530935196, 6423.325550817191, 6473.093766872547, 6474.902876456763, 6479.31967143462, 6491.318411566717, 6232.25212974446, 6277.686115694289, 6279.591826531444, 6281.0, 6282.246130464374, 5780.768769249183, 5964.568503559028, 6285.465735412358, 6374.58565193261, 6389.648569328546, 6225.844353891189, 6292.528060395397, 6295.5907865988565, 6314.0, 6327.968360158354, 6260.436560709558, 6273.466755325849, 6273.99616061428, 6290.370962903856, 6290.748370065146, 6122.6938653068055, 6162.876742465215, 6192.287886892885, 6227.657478838707, 6283.088952102011, 6145.801568694062, 6200.627962322275, 6208.534359922934, 6284.748610055546, 6288.591241569284, 6114.357992410733, 6127.3259941407305, 6127.601705889103, 6140.539459540463, 6145.985912324595, 6122.602030867979, 6243.375662433902, 6265.373462653698, 6286.18279623646, 6287.622742635456, 6042.546808989431, 6103.7253323601435, 6116.174316467398, 6142.385761423822, 6202.844928876814], "value": 5797.425828689626, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.12869034073896, 528.1496790167829, 535.2827211536543, 535.9705216213107, 537.827535971582, 26171.869140654293, 31730.524042139357, 32631.0, 32669.85655502058, 32683.509747353808, 42435.575644243545, 43699.781501092526, 43790.12419751603, 45917.31124033142, 46156.30765538511, 9748.220142388593, 9912.752181195456, 9929.255305852053, 9934.503274836265, 9947.651832185875, 8827.382083254175, 9940.204783617293, 10029.348092374008, 10032.147267482236, 10049.095581397673, 8841.071687472819, 12320.322382268972, 12593.181443206162, 12593.748125037493, 12595.3072581008, 12345.950594199503, 12392.752144957096, 12403.813942790865, 12432.75134497305, 12487.875121248762, 8846.911530884674, 9103.135202155785, 12233.143679942408, 12332.81500777489, 12336.259824410474, 40821.79589102065, 41035.58964410348, 41072.0, 42937.570624293985, 43018.0, 3392.8982130536124, 3430.468277417004, 3703.166787472797, 3938.3107956107565, 4122.9381559276635, 30621.540676889865, 30630.846845765627, 31738.0, 31799.52300715468, 33137.171570710685, 3214.791038582485, 3295.6869097435947, 3332.683395077464, 3397.96602033979, 3437.5015622734563, 461707.0, 462033.0, 462058.68970655266, 464921.0, 470309.0, 53505.7324713374, 53984.73007634937, 61952.69023654943, 61966.0, 62716.37283627196, 63327.68336158382, 66932.665336673, 66935.99192024246, 67016.6649166751, 67073.0, 16199.676006479804, 16437.93153445022, 16449.25978330978, 16453.91773041127, 16539.25573349202, 12498.25010499373, 12642.873571264354, 12655.620331390073, 12664.923481504175, 12669.683257918627, 11240.426340312362, 16028.75956860648, 17664.381746639065, 18066.638667226583, 18120.728189077174, 5607.915881261784, 6478.514111441661, 6563.081168636395, 6614.834629134214, 6616.966915165393, 869.1742844297816, 987.8715766950394, 1010.6109147978082, 1078.3907092492716, 1113.0872684398878, 29846.850765746032, 30489.542656860165, 30687.69312306893, 30805.845970770002, 31355.686443135277, 969.5249327829313, 1022.3814592171777, 1048.8059708953867, 1063.330102035728, 1077.256692881909, 12967.675808104872, 15954.521364359089, 15989.840101599068, 16213.165517930182, 16379.0172589645, 690167.0, 693939.0, 694389.0, 695150.0, 696217.0, 51274.48725512697, 52172.69568260748, 58582.70708646515, 59574.702126489094, 60061.798764024476, 1350.2506109109343, 1370.5682709946334, 1394.9721005579831, 1395.8185435893472, 1397.6925076483158, 30412.239694007825, 31643.367132657677, 32204.83897580497, 32243.51634725434, 32693.509597355584, 46675.0, 53607.6598085051, 53757.46242537525, 53786.731066344415, 53862.46137538574, 590136.0, 860463.0, 887986.0, 889674.0, 891327.1734565402, 26089.95640174372, 26359.736402635728, 26377.944882205265, 26383.736162638128, 26487.735122648526, 45740.0, 46118.76940615275, 46557.0, 46955.295670565654, 47037.059258815316, 38316.0, 38448.80775596104, 38905.41641875318, 39074.218515628956, 39238.626648068326, 38228.0, 38759.6124038756, 39168.6083139165, 39882.80058599688, 40165.79917100396, 37565.43651845279, 38298.0, 38334.0, 38648.80675596604, 39285.2142957145, 33793.81721639731, 35296.11759705925, 36143.81928090343, 36260.63739362573, 36557.90326290215, 25930.481390372464, 26432.471350572498, 26449.471010580066, 26654.333641658337, 26973.921043158054], "value": 20532.42394776689, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.37652377411973, 368.37928091166384, 375.74824867338873, 378.32657868993186, 401.6545770637251, 15213.695726085472, 15595.0, 16081.03513789172, 20670.0, 21006.264780732676, 19941.0, 20219.696704549442, 20786.480337991557, 20990.26534071308, 21017.579648407023, 4960.578350840165, 5945.524358051367, 6208.627482351051, 6212.689365531728, 6213.03697926822, 5603.8599035024245, 5765.4522820332, 6150.354212807658, 6168.84577885552, 6170.197874276338, 5785.103308987113, 5991.161237426763, 6140.754369825202, 6150.784722534712, 6157.415045570686, 6057.636541807484, 6093.664848433335, 6117.632942023471, 6122.357152498968, 6123.2652081750475, 5004.099262132815, 5204.869878253036, 5223.615741828418, 5237.423883372826, 5332.573394128461, 25297.873510632515, 25414.872925635253, 25506.872465637553, 25732.87133564339, 26222.86888565564, 2298.0, 2345.3433038749176, 2418.250342393846, 2466.3420080649503, 2910.63617047869, 14816.851831481763, 15402.921795474322, 15424.68629705542, 16616.418425355176, 16664.083475408846, 1801.4955812372557, 1805.83523627261, 1858.386732378312, 1881.1440794438497, 1958.4614231086566, 120476.99999999913, 120837.79162208353, 124248.0, 124555.3772231133, 125022.0, 9340.159385655188, 9797.755056123653, 10099.0, 10189.369700847978, 10377.9481102594, 12473.563425280254, 12588.433520491417, 12596.307203103917, 12601.495940162291, 12616.17994830333, 7883.84232315362, 8136.75589732309, 8137.226963438464, 8204.671813127527, 8223.54770487617, 8306.252437280673, 8379.0, 8393.992720873533, 8530.70142545008, 8551.486910785372, 3307.7595901536924, 3924.7841368724994, 3929.8035098245546, 3930.1353702185475, 4007.238624661305, 1873.2914058648835, 1935.3226370770399, 1947.0946010105085, 1952.687569988795, 1960.784313725489, 843.2537204573873, 896.9819255145457, 944.1596978688972, 980.7842274699698, 1013.1945103642622, 21125.89437052805, 21968.0, 21972.450688732908, 22061.779382206292, 22143.335699929026, 903.4579252448609, 914.3188324698009, 920.4707293306376, 929.7257309093834, 958.4584709639032, 10979.83530247047, 11398.943005285086, 11406.030487408498, 11457.506254587954, 11618.88381116178, 513224.0, 514496.0, 515494.0, 621598.0, 627969.8601506964, 121922.0, 128369.3581532105, 129291.18189681487, 131088.0, 131515.3424232892, 956.321012081416, 1000.1598657127902, 1014.2595904989399, 1017.8371460566274, 1017.9032991865761, 17690.027048512457, 18853.68024238345, 18898.0, 19685.21259149618, 19721.21115155435, 46300.53699462962, 47285.05429891314, 52659.73670131778, 52761.47238527566, 54784.45215547953, 80637.0, 81249.0, 81492.59253703694, 82343.7648435262, 82682.58658706667, 6883.483738719716, 7280.526765760209, 7833.412494063082, 8050.6779728812535, 8278.130796266547, 11515.596954106566, 12318.137730358789, 12484.750304994031, 12744.04419668547, 12863.742725145257, 8708.78228044304, 9949.602015919281, 10638.14894808429, 10792.838107428237, 10993.395363255098, 10725.0, 10857.891421085687, 10894.498278369372, 11386.544538218379, 11395.430228488709, 10698.786024279627, 10743.24797264184, 11214.887851121384, 11249.49377278008, 11401.885981140082, 6947.68735406918, 7285.890711639224, 7300.0, 7859.371250299848, 8233.50598964064, 10021.09810117093, 10601.363918164934, 10927.617533386294, 10983.725406864893, 10983.890161098287], "value": 9493.852706486849, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.8720471555198, 1485.873700735437, 1524.2912045898656, 1686.2159096020348, 1845.7508236388092, 7842.529448233103, 8362.163783621634, 8362.247397734203, 8365.832683346336, 8375.162483751621, 8583.227509524157, 8867.73396798097, 8873.20141187293, 9007.54962251888, 9009.369344145913, 2429.3440770991865, 2461.05249478951, 2461.1386014894824, 2461.852288862665, 2462.7167875694254, 2390.3319081630116, 2440.8779561021965, 2444.584420648494, 2445.7282213249186, 2448.2165706973774, 2420.5642984262827, 2427.526632306701, 2432.2338463383976, 2451.742567030463, 2455.742147074558, 2339.3683705399617, 2377.702787151606, 2394.628832530952, 2401.8318717689767, 2411.1440438644204, 2365.042157926043, 2412.5054363855365, 2412.9517409651885, 2413.481101563155, 2421.1767998880464, 8835.0, 9033.548322583845, 9035.412698174663, 9042.276617870555, 9057.049009853936, 5311.362636483608, 5319.760610772524, 5484.506394424521, 5488.4237155098535, 5492.5605951523785, 3704.0, 3763.2285381496727, 3777.2823163599105, 3790.8673196438267, 3795.3358162321483, 1090.5637744902024, 1095.6274866545334, 1124.7131981344787, 1138.299945533499, 1141.8401423800674, 12035.638930832089, 12128.57549985755, 12134.939325303494, 12138.514459421613, 12148.392580371035, 4383.824647014148, 4556.0432309214775, 4702.482726900038, 4758.214894542431, 4762.452317983476, 9332.673356432493, 9346.439213647203, 9352.064793520729, 9364.204042656314, 9375.06249375057, 5361.463853614685, 5363.383210930715, 5365.973170134124, 5367.624266301322, 5374.059539580558, 4042.4542686737504, 4413.117376524708, 4818.855434336975, 4826.734529600835, 5043.722595257296, 3336.9989003299397, 3695.2240029594086, 3728.254349130185, 3820.7516511427225, 3828.157805282833, 1143.3140115930541, 1180.9291442513477, 1185.6561597136733, 1191.642507247822, 1193.3496244546743, 812.6789917982364, 904.2223687628634, 912.9224015958586, 933.7012156109979, 959.491469521141, 5705.771769129271, 5900.970495147497, 6003.189569408161, 6068.6358818471035, 6198.101275315054, 438.56362918895906, 439.7427504909664, 440.77025099970723, 457.1953362082758, 457.76425141052385, 3911.3350730375337, 3930.508686414198, 3962.405639154092, 3980.283548961215, 4021.8190181441905, 9355.251579873593, 10685.412302323446, 11121.388323642277, 11148.331100134017, 11159.944200278947, 9787.951060244795, 10723.89276107229, 10931.781364372668, 11088.944555277172, 11101.1674124441, 7971.242731940456, 8213.301869341054, 8241.752747417468, 8428.283595894294, 8433.704820331259, 5919.940800591939, 5976.8804623908145, 6050.84872878164, 6053.182820319201, 6085.6348619083, 9956.751081223027, 9995.70012899614, 10141.797164056825, 10234.6417875374, 10300.124489418484, 8619.525926074126, 10402.791944161227, 10489.265751397328, 10514.789704206027, 10653.0, 6883.586984780929, 7058.294170582901, 7521.0, 7546.773596792105, 7717.382609391348, 8468.618912149092, 8660.220580147818, 8667.133286671282, 8669.869951950852, 8674.175953284428, 6866.965665171642, 7481.989931359197, 7566.848663026599, 7718.3053525183, 7830.3735701144915, 7367.77896663101, 7521.736739214321, 7590.051243594551, 7622.961885190539, 7689.231076892266, 6921.134858142732, 7068.399186069241, 7075.150981882207, 7084.752033678797, 7097.574145551283, 4832.63755218353, 4862.3922009748785, 4899.0, 5005.174146265826, 5061.493850614909, 4968.503149685002, 5004.2493625956395, 5060.342155519759, 5132.692038477703, 5183.455737147545], "value": 4524.724850341285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.3495128193615, 299.31307648945665, 304.42463743524735, 309.41983780411726, 311.7396973527105, 4321.049369138792, 4421.977890110549, 5131.61114412556, 5133.974330128344, 5351.331083614548, 4129.7522148671105, 4335.241332766769, 4475.843345482909, 5223.738813059351, 5259.474052594738, 4067.0, 4076.388541718751, 4079.4090304781157, 4081.6122468365534, 4090.6727461802984, 3577.7656708435547, 3772.4152756322815, 3920.353141731611, 4080.2047099276224, 4105.589441055886, 3326.7837590556537, 4011.1576568920564, 4011.699122565805, 4043.939340909889, 4055.837766489337, 3996.2407142642805, 4003.7597744135446, 4022.416749571325, 4034.576369481221, 4043.5147782266167, 3099.7210251077513, 3460.0657822387816, 3460.7058400036026, 3477.4088404971217, 3518.4546395308766, 4097.97951010246, 4559.544045595447, 4574.324020448042, 4595.448546174447, 4801.495842936476, 4402.0, 4556.111558246143, 4576.405067341224, 4585.5009020084135, 4597.37935378723, 4852.393450818648, 4944.21767347979, 5279.313689220377, 5527.585431092684, 5553.916691249635, 3167.509036099408, 3629.8565951725386, 3708.0173753955223, 3836.290286297044, 3973.662238709684, 4806.927896081562, 5815.389384114649, 5843.983825580168, 5866.6480011199465, 5933.317668468138, 3255.951160732591, 3827.9043023924623, 3832.846686132579, 3834.9233015339537, 3839.308924393636, 3115.8753649854207, 3257.2345498807763, 3582.731295152874, 3899.902502437462, 3935.8032098394965, 4360.4331436913, 4380.956190438055, 4504.774761261924, 4569.771511424416, 4606.424196975378, 4606.792694328763, 4660.97669511657, 5569.359523654832, 5615.578831587647, 5659.349174844946, 986.5264672957021, 1261.564760157744, 1281.39774306076, 1290.5160564788205, 1300.6878349196313, 809.3848675007036, 846.272205902923, 872.7076429396096, 877.5875338590852, 893.65147592439, 4435.846679863194, 5128.922926185468, 5274.525292723673, 5288.629795914326, 5323.0, 4292.462723087245, 4693.404242557479, 4735.12400205963, 5530.2810634618045, 5715.371309155989, 4220.409142720022, 4387.714798538085, 5144.742762861842, 5224.033553792485, 5242.9213561796605, 2122.898330652643, 2252.9636367271237, 2308.9653655195184, 2502.94994100117, 2516.5973444248834, 4445.555444455528, 4879.268109783561, 4885.951140488621, 4968.826091086795, 5535.778568857281, 4559.534753587298, 6019.4883434908525, 6022.247219097613, 6042.791441711675, 6059.36376680451, 5280.471952804765, 5877.882442351129, 6063.181470501426, 6068.33248342682, 6077.6353418795015, 4835.540623640749, 5401.6218864679095, 5504.587155963239, 5825.854353641193, 5844.357120716632, 4791.448983366958, 4900.387451568554, 5782.826515204551, 5796.855078623068, 5813.0, 5552.583556233218, 5714.314277288293, 6050.273967123973, 6050.364711705383, 6095.634261944298, 3497.527833742412, 3709.5919448860063, 3823.5411750590106, 3848.615138486129, 3944.6252606002386, 5303.310569625924, 5796.362400135898, 5807.912881306868, 5811.506021988178, 5836.299644042742, 5452.945470545244, 5710.086386178192, 5714.714264286852, 5755.453231942959, 5771.422857714195, 5666.603337766317, 5676.772929082956, 5706.201131841629, 5710.5717071219, 5714.485696287354, 4768.928466072943, 5233.973830130825, 5252.921206181987, 5389.51494365509, 5555.805546805843, 4769.880752981203, 5536.584756143386, 5643.492085712305, 5682.744276507649, 5804.448577385142, 4381.802818873095, 5245.842624721265, 5260.868478288074, 5556.666600004012, 5557.555395568425], "value": 3974.1664885433415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.500654496038, 681.7545683553919, 706.2196273118205, 776.8873513340566, 783.4711569690464, 11850.940745296271, 15116.848831511681, 15185.848141518596, 15217.239138043094, 16651.583710407245, 14745.48390806322, 15139.62150946227, 15149.545513634608, 15159.92420037901, 15210.543683689479, 652.693234179937, 672.294091204236, 676.898465230217, 810.226233946581, 828.5732847583499, 750.7334896111884, 817.9795505112361, 839.9244068033876, 847.8215280759749, 850.9958249265864, 883.9646414143426, 886.9689560865371, 887.2059506741494, 887.9378443508957, 887.995560022199, 693.729445516249, 715.3740477082553, 883.5052370672444, 883.9116088391141, 886.9246114080246, 626.0984182776787, 643.279526929837, 648.7275344355382, 650.3334082565408, 650.6779144323543, 15020.17389043602, 15036.548903532912, 15044.323005464781, 15064.246787660682, 15069.472568460162, 13966.860331396658, 14205.573832785032, 14217.289135543182, 14405.567832965027, 14415.855841441557, 12695.93652031734, 12911.327066437745, 12965.0, 13136.408861601156, 13530.86469135306, 4441.333799930037, 4454.688171827974, 4541.046380260149, 4546.681732278742, 4620.260758278693, 113218.43390783075, 116923.0, 117062.0, 117475.41262293719, 117775.41112294384, 10331.845022324671, 10940.343579385262, 10972.286801358046, 11141.944290278496, 11182.32906025641, 20764.896175519327, 21250.25624103149, 21275.0, 21299.148034078462, 21329.78670213309, 7399.7410090647645, 7597.5821329826285, 7679.040119985002, 7871.0948240951875, 7918.287354138155, 4295.2096495121095, 4394.560543945579, 4419.248727716296, 4462.3752674625575, 4581.083783243364, 3478.617352091268, 3485.233248685285, 3487.9651203488147, 3519.454484554898, 3598.5501812273465, 633.3476519185247, 634.1375729008545, 640.7340953504244, 640.9006603976391, 641.7978336823885, 538.7548665357332, 568.0286709726331, 624.2415465209701, 650.9357200976438, 667.1926968368232, 7885.960570197227, 8946.463212207289, 9045.954770226106, 9205.309601779893, 9238.953805231065, 588.4733163818444, 628.1237673445518, 629.8427884495676, 644.1786721929484, 647.8542327976262, 3887.319719049155, 4028.939565906514, 4436.844710435119, 4439.289713645801, 4440.600345968814, 118491.0, 120171.39914300373, 122285.0, 129504.0, 163858.0, 116183.0, 116535.41732291284, 117923.0, 118252.0, 122013.38993304977, 75606.62196688981, 96499.0, 107598.0, 108031.0, 110830.44584777186, 9661.937186909576, 9719.9028009719, 9765.755856103655, 9933.0, 10078.748031298983, 50717.0, 50920.0, 64696.35303646903, 65406.0, 65929.67035164793, 61871.0, 64388.67805660942, 74122.0, 87582.68625970744, 87807.12192877989, 11534.711632209262, 13901.860981390057, 13926.1079838265, 14060.718785624435, 14338.856611433752, 11965.700857478632, 14626.561203163923, 14789.704205916036, 14885.553433397015, 14911.403543858125, 13062.0, 13314.733705326033, 13489.595312140651, 13770.036097473481, 14319.0, 12886.935565322114, 13312.667183320495, 14296.0, 14722.969392142448, 14751.557453276419, 12934.417951192407, 14112.435502580192, 14305.0, 14311.928440357731, 14319.35562899693, 10016.699499015042, 11150.721231969266, 11529.0, 11854.288742675468, 12090.395480226129, 8186.672533098609, 9889.554251269185, 11561.595344162914, 11767.52929882795, 11821.349825759666], "value": 7669.22010272759, "unit": "score"}], "name": "dromaeo_css", "value": 7335.9997000429385, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 112.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 108.0, 150.0, 138.0, 139.0, 127.0, 106.0, 138.0, 108.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 181.0, 191.0, 257.0, 179.0, 180.0, 182.0, 186.0, 184.0, 181.0], "value": 190.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 60.0, 87.0, 60.0, 59.0, 59.0, 57.0, 91.0, 82.0], "value": 69.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 94.0, 69.0, 68.0, 68.0, 92.0, 68.0, 69.0, 112.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 88.0, 91.0, 87.0, 91.0, 88.0, 90.0, 87.0], "value": 88.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 83.0, 86.0, 83.0, 86.0, 86.0, 84.0, 81.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 52.0, 53.0, 57.0, 57.0, 57.0, 56.0, 57.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 74.0, 71.0, 69.0, 68.0, 70.0, 68.0, 68.0, 70.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 102.0, 105.0, 105.0, 83.0, 86.0, 81.0, 85.0, 86.0, 88.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 138.0, 137.0, 137.0, 140.0, 144.0, 139.0, 169.0, 126.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 162.0, 162.0, 164.0, 163.0, 170.0, 175.0, 148.0, 225.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 81.0, 85.0, 86.0, 81.0, 66.0, 66.0, 66.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1450.3999999999996, "alertThreshold": 2.0}]} 03:27:11 INFO - Return code: 0 03:27:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:27:11 INFO - # TBPL SUCCESS # 03:27:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:27:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:27:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:27:11 INFO - 2016-10-28 03:27:11.874 screenresolution[1671:10735] starting screenresolution argv=screenresolution get 03:27:11 INFO - 2016-10-28 03:27:11.877 screenresolution[1671:10735] Display 0: 1600x1200x32@60 03:27:11 INFO - 2016-10-28 03:27:11.883 screenresolution[1672:10738] starting screenresolution argv=screenresolution list 03:27:11 INFO - Available Modes on Display 0 03:27:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:27:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:27:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:27:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:27:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:27:12 INFO - Intel Iris: 03:27:12 INFO - Chipset Model: Intel Iris 03:27:12 INFO - Type: GPU 03:27:12 INFO - Bus: Built-In 03:27:12 INFO - VRAM (Dynamic, Max): 1536 MB 03:27:12 INFO - Vendor: Intel (0x8086) 03:27:12 INFO - Device ID: 0x0a2e 03:27:12 INFO - Revision ID: 0x0009 03:27:12 INFO - Displays: 03:27:12 INFO - Display: 03:27:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:27:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:27:12 INFO - Display Serial Number: 1600x1200 60 03:27:12 INFO - Main Display: Yes 03:27:12 INFO - Mirror: Off 03:27:12 INFO - Online: Yes 03:27:12 INFO - Rotation: Supported 03:27:12 INFO - Return code: 0 03:27:12 INFO - Running post-action listener: _resource_record_post_action 03:27:12 INFO - [mozharness: 2016-10-28 10:27:12.120521Z] Finished run-tests step (success) 03:27:12 INFO - Running post-run listener: _resource_record_post_run 03:27:12 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 32152576; Write bytes: 662845440; Read time: 196; Write time: 1892 03:27:12 INFO - TinderboxPrint: CPU usage
53.2% 03:27:12 INFO - TinderboxPrint: I/O read bytes / time
32,152,576 / 196 03:27:12 INFO - TinderboxPrint: I/O write bytes / time
662,845,440 / 1,892 03:27:12 INFO - TinderboxPrint: CPU idle
2,267.8 (46.8%) 03:27:12 INFO - TinderboxPrint: CPU system
969.6 (20.0%) 03:27:12 INFO - TinderboxPrint: CPU user
1,608.4 (33.2%) 03:27:12 INFO - TinderboxPrint: Swap in / out
391,757,824 / 0 03:27:12 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 364415488; Write bytes: 366495744; Read time: 28753; Write time: 776 03:27:12 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 30108672; Write bytes: 295219200; Read time: 177; Write time: 1112 03:27:12 INFO - Running post-run listener: _upload_blobber_files 03:27:12 INFO - Blob upload gear active. 03:27:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:27:12 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 03:27:12 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'] 03:27:12 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 03:27:13 INFO - (blobuploader) - INFO - Open directory for files ... 03:27:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:27:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:27:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:14 INFO - (blobuploader) - INFO - Done attempting. 03:27:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:27:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:27:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:15 INFO - (blobuploader) - INFO - Done attempting. 03:27:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:27:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:27:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:18 INFO - (blobuploader) - INFO - Done attempting. 03:27:18 INFO - (blobuploader) - INFO - Iteration through files over. 03:27:18 INFO - Return code: 0 03:27:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:27:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:27:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ff75b7dfc4842a54ed0dff09afc124c1187413dd39428acc1f74fe055e1608c6ef880d4ccc271dc83f63688d987c0fea4900b3e30b91ec1a1b040ee55414e58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2e7d867f8caa9eaf4bd9956d922134173f6085e9ca80a8d89bc6789ea720a8431ce61ae93aec417f0741d550099bb82a8e1b55bd6667169fd77f408c5b8e684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b45b072502206bb077b5fabbfe5147c991460888bb7a70d31aa5dd11056b9d0bd41bb6d9b85b30f60d18b9d2c1483b9c13f9cc9d5ce0b8a238f240c18e67daa"} 03:27:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:27:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:27:18 INFO - Contents: 03:27:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ff75b7dfc4842a54ed0dff09afc124c1187413dd39428acc1f74fe055e1608c6ef880d4ccc271dc83f63688d987c0fea4900b3e30b91ec1a1b040ee55414e58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2e7d867f8caa9eaf4bd9956d922134173f6085e9ca80a8d89bc6789ea720a8431ce61ae93aec417f0741d550099bb82a8e1b55bd6667169fd77f408c5b8e684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b45b072502206bb077b5fabbfe5147c991460888bb7a70d31aa5dd11056b9d0bd41bb6d9b85b30f60d18b9d2c1483b9c13f9cc9d5ce0b8a238f240c18e67daa"} 03:27:18 INFO - Running post-run listener: copy_logs_to_upload_dir 03:27:18 INFO - Copying logs to upload dir... 03:27:18 INFO - mkdir: /builds/slave/test/build/upload/logs 03:27:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.490929 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-28 03:27:18.540408) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:18.543893) ========= 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.M3f6xzH47p/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.rPzO29AAWY/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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/3ff75b7dfc4842a54ed0dff09afc124c1187413dd39428acc1f74fe055e1608c6ef880d4ccc271dc83f63688d987c0fea4900b3e30b91ec1a1b040ee55414e58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2e7d867f8caa9eaf4bd9956d922134173f6085e9ca80a8d89bc6789ea720a8431ce61ae93aec417f0741d550099bb82a8e1b55bd6667169fd77f408c5b8e684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b45b072502206bb077b5fabbfe5147c991460888bb7a70d31aa5dd11056b9d0bd41bb6d9b85b30f60d18b9d2c1483b9c13f9cc9d5ce0b8a238f240c18e67daa"} build_url:https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011022 build_url: 'https://queue.taskcluster.net/v1/task/bDRA090YQJST5KpBeYlrUg/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/3ff75b7dfc4842a54ed0dff09afc124c1187413dd39428acc1f74fe055e1608c6ef880d4ccc271dc83f63688d987c0fea4900b3e30b91ec1a1b040ee55414e58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2e7d867f8caa9eaf4bd9956d922134173f6085e9ca80a8d89bc6789ea720a8431ce61ae93aec417f0741d550099bb82a8e1b55bd6667169fd77f408c5b8e684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b45b072502206bb077b5fabbfe5147c991460888bb7a70d31aa5dd11056b9d0bd41bb6d9b85b30f60d18b9d2c1483b9c13f9cc9d5ce0b8a238f240c18e67daa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:18.575777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:18.576072) ========= 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.M3f6xzH47p/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.rPzO29AAWY/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005417 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:18.624370) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 03:27:18.624694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 03:27:18.625007) ========= ========= Total master_lag: 0.17 =========