builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0274 starttime: 1489684721.1 results: success (0) buildid: 20170316084022 builduid: ad557631f54b4a989b556b007474a9c2 revision: 77fdb54e3df6e491aaf66ee6bc1f3aa8edba3367 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:41.103590) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:41.104042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:41.104329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:41.130788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:41.131145) ========= 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.BXFEc4Pt42/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.GiyIbVqt60/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-16 10:18:41-- 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% 69.5M=0s 2017-03-16 10:18:41 (69.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161982 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:41.317244) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:41.317563) ========= 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.BXFEc4Pt42/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.GiyIbVqt60/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.025236 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:41.365559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-16 10:18:41.365928) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 77fdb54e3df6e491aaf66ee6bc1f3aa8edba3367 --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 77fdb54e3df6e491aaf66ee6bc1f3aa8edba3367 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BXFEc4Pt42/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.GiyIbVqt60/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-16 10:18:41,485 truncating revision to first 12 chars 2017-03-16 10:18:41,485 Setting DEBUG logging. 2017-03-16 10:18:41,485 attempt 1/10 2017-03-16 10:18:41,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/77fdb54e3df6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-16 10:18:42,189 unpacking tar archive at: mozilla-aurora-77fdb54e3df6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.981916 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-16 10:18:42.371416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:42.371761) ========= script_repo_revision: 77fdb54e3df6e491aaf66ee6bc1f3aa8edba3367 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:42.372158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:42.372432) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 10:18:42.391974) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-03-16 10:18:42.392284) ========= /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.BXFEc4Pt42/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.GiyIbVqt60/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 10:18:42 INFO - MultiFileLogger online at 20170316 10:18:42 in /builds/slave/test 10:18:42 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 10:18:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:18:42 INFO - {'append_to_log': False, 10:18:42 INFO - 'base_work_dir': '/builds/slave/test', 10:18:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:18:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:18:42 INFO - 'branch': 'Mozilla-Aurora', 10:18:42 INFO - 'buildbot_json_path': 'buildprops.json', 10:18:42 INFO - 'config_files': ('talos/mac_config.py',), 10:18:42 INFO - 'default_actions': ('clobber', 10:18:42 INFO - 'read-buildbot-config', 10:18:42 INFO - 'download-and-extract', 10:18:42 INFO - 'populate-webroot', 10:18:42 INFO - 'create-virtualenv', 10:18:42 INFO - 'install', 10:18:42 INFO - 'run-tests'), 10:18:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:18:42 INFO - 'download_minidump_stackwalk': True, 10:18:42 INFO - 'download_symbols': 'ondemand', 10:18:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:18:42 INFO - 'tooltool.py': '/tools/tooltool.py', 10:18:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:18:42 INFO - '/tools/misc-python/virtualenv.py')}, 10:18:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:18:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:18:42 INFO - 'gecko_profile': False, 10:18:42 INFO - 'gecko_profile_interval': 0, 10:18:42 INFO - 'installer_path': 'installer.exe', 10:18:42 INFO - 'log_level': 'info', 10:18:42 INFO - 'log_name': 'talos', 10:18:42 INFO - 'log_to_console': True, 10:18:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:18:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:18:42 INFO - 'opt_config_files': (), 10:18:42 INFO - 'pip_index': False, 10:18:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:18:42 INFO - 'cmd': ('bash', 10:18:42 INFO - '-c', 10:18:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:18:42 INFO - 'enabled': True, 10:18:42 INFO - 'halt_on_failure': False, 10:18:42 INFO - 'name': 'check_screen_resolution'},), 10:18:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:18:42 INFO - 'cmd': ('bash', 10:18:42 INFO - '-c', 10:18:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:18:42 INFO - 'enabled': True, 10:18:42 INFO - 'halt_on_failure': False, 10:18:42 INFO - 'name': 'check_screen_resolution'},), 10:18:42 INFO - 'run_cmd_checks_enabled': True, 10:18:42 INFO - 'suite': 'dromaeojs', 10:18:42 INFO - 'system_bits': '32', 10:18:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:18:42 INFO - 'title': 't-yosemite-r7-0274', 10:18:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:18:42 INFO - 'use_talos_json': True, 10:18:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:18:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:18:42 INFO - 'work_dir': 'build'} 10:18:42 INFO - [mozharness: 2017-03-16 17:18:42.621024Z] Running clobber step. 10:18:42 INFO - Running pre-action listener: _resource_record_pre_action 10:18:42 INFO - Running main action method: clobber 10:18:42 INFO - rmtree: /builds/slave/test/build 10:18:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:18:45 INFO - Running post-action listener: _resource_record_post_action 10:18:45 INFO - [mozharness: 2017-03-16 17:18:45.006658Z] Finished clobber step (success) 10:18:45 INFO - [mozharness: 2017-03-16 17:18:45.006843Z] Running read-buildbot-config step. 10:18:45 INFO - Running pre-action listener: _resource_record_pre_action 10:18:45 INFO - Running main action method: read_buildbot_config 10:18:45 INFO - Using buildbot properties: 10:18:45 INFO - { 10:18:45 INFO - "project": "", 10:18:45 INFO - "product": "firefox", 10:18:45 INFO - "script_repo_revision": "production", 10:18:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 10:18:45 INFO - "repository": "", 10:18:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 10:18:45 INFO - "buildid": "20170316084022", 10:18:45 INFO - "pgo_build": "False", 10:18:45 INFO - "basedir": "/builds/slave/test", 10:18:45 INFO - "buildnumber": 66, 10:18:45 INFO - "slavename": "t-yosemite-r7-0274", 10:18:45 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:18:45 INFO - "platform": "yosemite_r7", 10:18:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:18:45 INFO - "branch": "mozilla-aurora", 10:18:45 INFO - "repo_path": "releases/mozilla-aurora", 10:18:45 INFO - "revision": "77fdb54e3df6e491aaf66ee6bc1f3aa8edba3367", 10:18:45 INFO - "stage_platform": "macosx64", 10:18:45 INFO - "builduid": "ad557631f54b4a989b556b007474a9c2", 10:18:45 INFO - "slavebuilddir": "test" 10:18:45 INFO - } 10:18:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 10:18:45 INFO - Running post-action listener: _resource_record_post_action 10:18:45 INFO - [mozharness: 2017-03-16 17:18:45.010108Z] Finished read-buildbot-config step (success) 10:18:45 INFO - [mozharness: 2017-03-16 17:18:45.010242Z] Running download-and-extract step. 10:18:45 INFO - Running pre-action listener: _resource_record_pre_action 10:18:45 INFO - Running main action method: download_and_extract 10:18:45 INFO - mkdir: /builds/slave/test/build/tests 10:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:45 INFO - trying https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 10:18:45 INFO - Downloading https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 10:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 10:18:46 INFO - Downloaded 1199 bytes. 10:18:46 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 10:18:46 INFO - Using the following test package requirements: 10:18:46 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 10:18:46 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 10:18:46 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 10:18:46 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:18:46 INFO - u'jsshell-mac.zip'], 10:18:46 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 10:18:46 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 10:18:46 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 10:18:46 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 10:18:46 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 10:18:46 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 10:18:46 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:18:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 10:18:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:18:46 INFO - Fetch https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 10:18:47 INFO - Expected file size: 51782245 10:18:47 INFO - Obtained file size: 51782245 10:19:04 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:19:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 10:19:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:19:04 INFO - Fetch https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 10:19:05 INFO - Expected file size: 51782245 10:19:05 INFO - Obtained file size: 51782245 10:19:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 10:19:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:19:20 INFO - Fetch https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 10:19:22 INFO - Expected file size: 14404424 10:19:22 INFO - Obtained file size: 14404424 10:19:22 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')]} 10:19:22 INFO - trying https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 10:19:22 INFO - Downloading https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 10:19:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 10:19:24 INFO - Downloaded 74628481 bytes. 10:19:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 10:19:24 INFO - mkdir: /builds/slave/test/properties 10:19:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:19:24 INFO - Writing to file /builds/slave/test/properties/build_url 10:19:24 INFO - Contents: 10:19:24 INFO - build_url:https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 10:19:25 INFO - Running post-action listener: _resource_record_post_action 10:19:25 INFO - Running post-action listener: set_extra_try_arguments 10:19:25 INFO - [mozharness: 2017-03-16 17:19:25.383437Z] Finished download-and-extract step (success) 10:19:25 INFO - [mozharness: 2017-03-16 17:19:25.383565Z] Running populate-webroot step. 10:19:25 INFO - Running pre-action listener: _resource_record_pre_action 10:19:25 INFO - Running main action method: populate_webroot 10:19:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:25 INFO - '--tppagecycles', 10:19:25 INFO - '7'], 10:19:25 INFO - 'tests': ['tsvgm']}}, 10:19:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:19:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:19:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:19:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:19:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:19:25 INFO - 'talos_options': ['--disable-e10s'], 10:19:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:19:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:19:25 INFO - 'talos_options': ['--disable-e10s'], 10:19:25 INFO - 'tests': ['damp', 'tps']}, 10:19:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:19:25 INFO - 'tests': ['damp', 'tps']}, 10:19:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:19:25 INFO - 'tests': ['dromaeo_dom']}, 10:19:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:19:25 INFO - 'tests': ['basic_compositor_video']}, 10:19:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:19:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:19:25 INFO - 'tests': ['a11yr', 10:19:25 INFO - 'ts_paint', 10:19:25 INFO - 'tpaint', 10:19:25 INFO - 'sessionrestore', 10:19:25 INFO - 'sessionrestore_no_auto_restore', 10:19:25 INFO - 'tabpaint']}, 10:19:25 INFO - 'other-e10s': {'tests': ['a11yr', 10:19:25 INFO - 'ts_paint', 10:19:25 INFO - 'tpaint', 10:19:25 INFO - 'sessionrestore', 10:19:25 INFO - 'sessionrestore_no_auto_restore', 10:19:25 INFO - 'tabpaint']}, 10:19:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:19:25 INFO - 'ts_paint', 10:19:25 INFO - 'tpaint', 10:19:25 INFO - 'sessionrestore', 10:19:25 INFO - 'sessionrestore_no_auto_restore', 10:19:25 INFO - 'tabpaint']}, 10:19:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:19:25 INFO - 'ts_paint', 10:19:25 INFO - 'tpaint', 10:19:25 INFO - 'sessionrestore', 10:19:25 INFO - 'sessionrestore_no_auto_restore', 10:19:25 INFO - 'tabpaint']}, 10:19:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:19:25 INFO - 'tests': ['a11yr', 10:19:25 INFO - 'ts_paint', 10:19:25 INFO - 'tpaint', 10:19:25 INFO - 'sessionrestore', 10:19:25 INFO - 'sessionrestore_no_auto_restore', 10:19:25 INFO - 'tabpaint']}, 10:19:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:19:25 INFO - 'tests': ['a11yr', 10:19:25 INFO - 'ts_paint', 10:19:25 INFO - 'tpaint', 10:19:25 INFO - 'sessionrestore', 10:19:25 INFO - 'sessionrestore_no_auto_restore', 10:19:25 INFO - 'tabpaint']}, 10:19:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:19:25 INFO - 'tests': ['tsvgx', 10:19:25 INFO - 'tsvgr_opacity', 10:19:25 INFO - 'tart', 10:19:25 INFO - 'tscrollx', 10:19:25 INFO - 'cart', 10:19:25 INFO - 'tsvg_static']}, 10:19:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:19:25 INFO - 'tsvgr_opacity', 10:19:25 INFO - 'tart', 10:19:25 INFO - 'tscrollx', 10:19:25 INFO - 'cart', 10:19:25 INFO - 'tsvg_static']}, 10:19:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:19:25 INFO - 'talos_options': ['--disable-e10s'], 10:19:25 INFO - 'tests': ['tp5o']}, 10:19:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:19:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:19:25 INFO - 'talos_options': ['--disable-e10s', 10:19:25 INFO - '--xperf_path', 10:19:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:25 INFO - 'tests': ['tp5n']}, 10:19:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:19:25 INFO - 'talos_options': ['--xperf_path', 10:19:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:25 INFO - 'tests': ['tp5n']}}, 10:19:25 INFO - 'talos.zip': {'path': '', 10:19:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:25 INFO - Running post-action listener: _resource_record_post_action 10:19:25 INFO - [mozharness: 2017-03-16 17:19:25.401979Z] Finished populate-webroot step (success) 10:19:25 INFO - [mozharness: 2017-03-16 17:19:25.402056Z] Running create-virtualenv step. 10:19:25 INFO - Running pre-action listener: _resource_record_pre_action 10:19:25 INFO - Running main action method: create_virtualenv 10:19:25 INFO - Creating virtualenv /builds/slave/test/build/venv 10:19:25 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 10:19:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:19:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:25 INFO - Using real prefix '/tools/python27' 10:19:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:19:26 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:29 INFO - Installing pip.................done. 10:19:29 INFO - Return code: 0 10:19:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:19:29 INFO - Reading from file tmpfile_stdout 10:19:29 INFO - Output received: 10:19:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:19:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:19:29 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')]} 10:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:29 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')]} 10:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:29 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 0x10ac0ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac0d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51b479a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e8d30>, '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 0x10a90fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9ddbe8>, '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.BXFEc4Pt42/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.GiyIbVqt60/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 10:19:29 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 10:19:29 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 10:19:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXFEc4Pt42/Render', 10:19:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:29 INFO - 'HOME': '/Users/cltbld', 10:19:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:29 INFO - 'LOGNAME': 'cltbld', 10:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:29 INFO - 'MOZ_NO_REMOTE': '1', 10:19:29 INFO - 'NO_EM_RESTART': '1', 10:19:29 INFO - 'PAGER': '/bin/cat', 10:19:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:29 INFO - 'PWD': '/builds/slave/test', 10:19:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:29 INFO - 'SHELL': '/bin/bash', 10:19:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiyIbVqt60/Listeners', 10:19:29 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 10:19:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:29 INFO - 'USER': 'cltbld', 10:19:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:29 INFO - 'XPC_FLAGS': '0x0', 10:19:29 INFO - 'XPC_SERVICE_NAME': '0', 10:19:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:29 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 10:19:29 INFO - Cleaning up... 10:19:29 INFO - Return code: 0 10:19:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:19:29 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')]} 10:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:29 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')]} 10:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:29 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 0x10ac0ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac0d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51b479a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e8d30>, '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 0x10a90fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9ddbe8>, '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.BXFEc4Pt42/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.GiyIbVqt60/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 10:19:29 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 10:19:29 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 10:19:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXFEc4Pt42/Render', 10:19:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:29 INFO - 'HOME': '/Users/cltbld', 10:19:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:29 INFO - 'LOGNAME': 'cltbld', 10:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:29 INFO - 'MOZ_NO_REMOTE': '1', 10:19:29 INFO - 'NO_EM_RESTART': '1', 10:19:29 INFO - 'PAGER': '/bin/cat', 10:19:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:29 INFO - 'PWD': '/builds/slave/test', 10:19:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:29 INFO - 'SHELL': '/bin/bash', 10:19:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiyIbVqt60/Listeners', 10:19:29 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 10:19:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:29 INFO - 'USER': 'cltbld', 10:19:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:29 INFO - 'XPC_FLAGS': '0x0', 10:19:29 INFO - 'XPC_SERVICE_NAME': '0', 10:19:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:29 INFO - Downloading/unpacking psutil>=3.1.1 10:19:29 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 10:19:29 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 10:19:29 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 10:19:29 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 10:19:29 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 10:19:29 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 10:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:33 INFO - Installing collected packages: psutil 10:19:33 INFO - Running setup.py install for psutil 10:19:33 INFO - building 'psutil._psutil_osx' extension 10:19:33 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 10:19:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:19:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:19:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:19:34 INFO - building 'psutil._psutil_posix' extension 10:19:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:19:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:19:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:19:34 INFO - ^ 10:19:34 INFO - 1 warning generated. 10:19:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:19:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:34 INFO - Successfully installed psutil 10:19:34 INFO - Cleaning up... 10:19:34 INFO - Return code: 0 10:19:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:19:34 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')]} 10:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:34 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')]} 10:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:34 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 0x10ac0ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac0d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51b479a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e8d30>, '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 0x10a90fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9ddbe8>, '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.BXFEc4Pt42/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.GiyIbVqt60/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 10:19:34 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 10:19:34 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 10:19:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXFEc4Pt42/Render', 10:19:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:34 INFO - 'HOME': '/Users/cltbld', 10:19:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:34 INFO - 'LOGNAME': 'cltbld', 10:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:34 INFO - 'MOZ_NO_REMOTE': '1', 10:19:34 INFO - 'NO_EM_RESTART': '1', 10:19:34 INFO - 'PAGER': '/bin/cat', 10:19:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:34 INFO - 'PWD': '/builds/slave/test', 10:19:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:34 INFO - 'SHELL': '/bin/bash', 10:19:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiyIbVqt60/Listeners', 10:19:34 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 10:19:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:34 INFO - 'USER': 'cltbld', 10:19:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:34 INFO - 'XPC_FLAGS': '0x0', 10:19:34 INFO - 'XPC_SERVICE_NAME': '0', 10:19:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:19:37 INFO - Installing collected packages: mozsystemmonitor 10:19:37 INFO - Running setup.py install for mozsystemmonitor 10:19:37 INFO - Successfully installed mozsystemmonitor 10:19:37 INFO - Cleaning up... 10:19:38 INFO - Return code: 0 10:19:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac0ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac0d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51b479a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e8d30>, '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 0x10a90fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9ddbe8>, '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.BXFEc4Pt42/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.GiyIbVqt60/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 10:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:19:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXFEc4Pt42/Render', 10:19:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:38 INFO - 'HOME': '/Users/cltbld', 10:19:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:38 INFO - 'LOGNAME': 'cltbld', 10:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:38 INFO - 'MOZ_NO_REMOTE': '1', 10:19:38 INFO - 'NO_EM_RESTART': '1', 10:19:38 INFO - 'PAGER': '/bin/cat', 10:19:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:38 INFO - 'PWD': '/builds/slave/test', 10:19:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:38 INFO - 'SHELL': '/bin/bash', 10:19:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiyIbVqt60/Listeners', 10:19:38 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 10:19:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:38 INFO - 'USER': 'cltbld', 10:19:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:38 INFO - 'XPC_FLAGS': '0x0', 10:19:38 INFO - 'XPC_SERVICE_NAME': '0', 10:19:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:39 INFO - Downloading/unpacking jsonschema==2.5.1 10:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:19:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:19:42 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 10:19:42 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 10:19:42 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 10:19:42 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 10:19:42 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 10:19:42 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 10:19:42 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:42 INFO - warning: no files found matching '*.txt' 10:19:42 INFO - no previously-included directories found matching 'build' 10:19:42 INFO - no previously-included directories found matching 'dist' 10:19:42 INFO - no previously-included directories found matching '.git*' 10:19:42 INFO - Installing collected packages: jsonschema, functools32 10:19:42 INFO - Running setup.py install for functools32 10:19:42 INFO - warning: no files found matching '*.txt' 10:19:42 INFO - no previously-included directories found matching 'build' 10:19:42 INFO - no previously-included directories found matching 'dist' 10:19:42 INFO - no previously-included directories found matching '.git*' 10:19:42 INFO - Successfully installed jsonschema functools32 10:19:42 INFO - Cleaning up... 10:19:43 INFO - Return code: 0 10:19:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:19:43 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')]} 10:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:43 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')]} 10:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:43 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 0x10ac0ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac0d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51b479a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e8d30>, '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 0x10a90fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9ddbe8>, '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.BXFEc4Pt42/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.GiyIbVqt60/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 10:19:43 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 10:19:43 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 10:19:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXFEc4Pt42/Render', 10:19:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:43 INFO - 'HOME': '/Users/cltbld', 10:19:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:43 INFO - 'LOGNAME': 'cltbld', 10:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:43 INFO - 'MOZ_NO_REMOTE': '1', 10:19:43 INFO - 'NO_EM_RESTART': '1', 10:19:43 INFO - 'PAGER': '/bin/cat', 10:19:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:43 INFO - 'PWD': '/builds/slave/test', 10:19:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:43 INFO - 'SHELL': '/bin/bash', 10:19:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiyIbVqt60/Listeners', 10:19:43 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 10:19:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:43 INFO - 'USER': 'cltbld', 10:19:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:43 INFO - 'XPC_FLAGS': '0x0', 10:19:43 INFO - 'XPC_SERVICE_NAME': '0', 10:19:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:19:43 INFO - Cleaning up... 10:19:43 INFO - Return code: 0 10:19:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19:43 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')]} 10:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:43 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')]} 10:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:43 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 0x10ac0ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac0d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51b479a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e8d30>, '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 0x10a90fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9ddbe8>, '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.BXFEc4Pt42/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.GiyIbVqt60/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 10:19:43 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 10:19:43 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 10:19:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXFEc4Pt42/Render', 10:19:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:43 INFO - 'HOME': '/Users/cltbld', 10:19:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:43 INFO - 'LOGNAME': 'cltbld', 10:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:43 INFO - 'MOZ_NO_REMOTE': '1', 10:19:43 INFO - 'NO_EM_RESTART': '1', 10:19:43 INFO - 'PAGER': '/bin/cat', 10:19:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:43 INFO - 'PWD': '/builds/slave/test', 10:19:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:43 INFO - 'SHELL': '/bin/bash', 10:19:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiyIbVqt60/Listeners', 10:19:43 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 10:19:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:43 INFO - 'USER': 'cltbld', 10:19:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:43 INFO - 'XPC_FLAGS': '0x0', 10:19:43 INFO - 'XPC_SERVICE_NAME': '0', 10:19:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:43 INFO - Downloading/unpacking blobuploader==1.2.4 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19:46 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 10:19:46 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 10:19:46 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 10:19:46 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 10:19:46 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 10:19:46 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 10:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:47 INFO - Downloading docopt-0.6.1.tar.gz 10:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:47 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:47 INFO - Running setup.py install for blobuploader 10:19:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:47 INFO - Running setup.py install for requests 10:19:48 INFO - Running setup.py install for docopt 10:19:48 INFO - Successfully installed blobuploader requests docopt 10:19:48 INFO - Cleaning up... 10:19:48 INFO - Return code: 0 10:19:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:48 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 0x10ac0ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac0d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51b479a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e8d30>, '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 0x10a90fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9ddbe8>, '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.BXFEc4Pt42/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.GiyIbVqt60/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 10:19:48 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 10:19:48 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 10:19:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXFEc4Pt42/Render', 10:19:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:48 INFO - 'HOME': '/Users/cltbld', 10:19:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:48 INFO - 'LOGNAME': 'cltbld', 10:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:48 INFO - 'MOZ_NO_REMOTE': '1', 10:19:48 INFO - 'NO_EM_RESTART': '1', 10:19:48 INFO - 'PAGER': '/bin/cat', 10:19:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:48 INFO - 'PWD': '/builds/slave/test', 10:19:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:48 INFO - 'SHELL': '/bin/bash', 10:19:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiyIbVqt60/Listeners', 10:19:48 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 10:19:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:48 INFO - 'USER': 'cltbld', 10:19:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:48 INFO - 'XPC_FLAGS': '0x0', 10:19:48 INFO - 'XPC_SERVICE_NAME': '0', 10:19:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:48 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-yn_SqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:48 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-dcrSqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:48 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-NwvQ7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:49 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-SaNZo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:49 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Y6iNDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:49 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Yl6J69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:49 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-jTvu2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:49 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-KuaWgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:49 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-d66yw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:49 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-jq5c6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:49 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-PB5zBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:49 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-rOnf2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:49 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-mMe23t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:50 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-0mHTcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:50 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-JDZGNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:50 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-dvH4ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:50 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-IO0TQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:50 INFO - Running setup.py install for manifestparser 10:19:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:19:50 INFO - Running setup.py install for mozcrash 10:19:50 INFO - Running setup.py install for mozdebug 10:19:50 INFO - Running setup.py install for mozdevice 10:19:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:19:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:19:51 INFO - Running setup.py install for mozfile 10:19:51 INFO - Running setup.py install for mozhttpd 10:19:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:19:51 INFO - Running setup.py install for mozinfo 10:19:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:19:51 INFO - Running setup.py install for mozInstall 10:19:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:19:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:19:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:19:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:19:51 INFO - Running setup.py install for mozleak 10:19:51 INFO - Running setup.py install for mozlog 10:19:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:19:52 INFO - Running setup.py install for moznetwork 10:19:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:19:52 INFO - Running setup.py install for mozprocess 10:19:52 INFO - Running setup.py install for mozprofile 10:19:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:19:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:19:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:19:52 INFO - Running setup.py install for mozrunner 10:19:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:19:52 INFO - Running setup.py install for mozscreenshot 10:19:52 INFO - Running setup.py install for moztest 10:19:52 INFO - Running setup.py install for mozversion 10:19:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:53 INFO - Cleaning up... 10:19:53 INFO - Return code: 0 10:19:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:53 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 0x10ac0ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac0d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51b479a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e8d30>, '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 0x10a90fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9ddbe8>, '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.BXFEc4Pt42/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.GiyIbVqt60/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 10:19:53 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 10:19:53 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 10:19:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXFEc4Pt42/Render', 10:19:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:53 INFO - 'HOME': '/Users/cltbld', 10:19:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:53 INFO - 'LOGNAME': 'cltbld', 10:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:53 INFO - 'MOZ_NO_REMOTE': '1', 10:19:53 INFO - 'NO_EM_RESTART': '1', 10:19:53 INFO - 'PAGER': '/bin/cat', 10:19:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:53 INFO - 'PWD': '/builds/slave/test', 10:19:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:53 INFO - 'SHELL': '/bin/bash', 10:19:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiyIbVqt60/Listeners', 10:19:53 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 10:19:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:53 INFO - 'USER': 'cltbld', 10:19:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:53 INFO - 'XPC_FLAGS': '0x0', 10:19:53 INFO - 'XPC_SERVICE_NAME': '0', 10:19:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-y0yZwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:53 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)) 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-AJCFe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-suKXB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:53 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)) 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-yRIZo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-_JFzyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:53 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)) 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-fTX967-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19: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)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-UIC1p6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:54 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)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-n5uXjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:54 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)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-It9rgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:54 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)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-F7ivg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:54 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)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Ldlf2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:54 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)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-PvBscG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-vOLq2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:54 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)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-0KP1ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-jpEVwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:54 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)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-fqsDYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:55 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-LopNpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:55 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)) 10:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:55 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)) 10:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:55 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 10:19:55 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 10:19:55 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 10:19:55 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 10:19:55 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 10:19:55 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 10:19:59 INFO - Downloading blessings-1.6.tar.gz 10:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:59 INFO - Installing collected packages: blessings 10:19:59 INFO - Running setup.py install for blessings 10:19:59 INFO - Successfully installed blessings 10:19:59 INFO - Cleaning up... 10:19:59 INFO - Return code: 0 10:19:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:00 INFO - Reading from file tmpfile_stdout 10:20:00 INFO - Current package versions: 10:20:00 INFO - blessings == 1.6 10:20:00 INFO - blobuploader == 1.2.4 10:20:00 INFO - docopt == 0.6.1 10:20:00 INFO - functools32 == 3.2.3-2 10:20:00 INFO - jsonschema == 2.5.1 10:20:00 INFO - manifestparser == 1.1 10:20:00 INFO - mozInstall == 1.12 10:20:00 INFO - mozcrash == 1.0 10:20:00 INFO - mozdebug == 0.1 10:20:00 INFO - mozdevice == 0.49 10:20:00 INFO - mozfile == 1.2 10:20:00 INFO - mozhttpd == 0.7 10:20:00 INFO - mozinfo == 0.9 10:20:00 INFO - mozleak == 0.1 10:20:00 INFO - mozlog == 3.4 10:20:00 INFO - moznetwork == 0.27 10:20:00 INFO - mozprocess == 0.25 10:20:00 INFO - mozprofile == 0.28 10:20:00 INFO - mozrunner == 6.13 10:20:00 INFO - mozscreenshot == 0.1 10:20:00 INFO - mozsystemmonitor == 0.3 10:20:00 INFO - moztest == 0.8 10:20:00 INFO - mozversion == 1.4 10:20:00 INFO - psutil == 3.1.1 10:20:00 INFO - requests == 1.2.3 10:20:00 INFO - wsgiref == 0.1.2 10:20:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:00 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 0x10ac0ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac0d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51b479a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e8d30>, '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 0x10a90fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9ddbe8>, '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.BXFEc4Pt42/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.GiyIbVqt60/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 10:20:00 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 10:20:00 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 10:20:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXFEc4Pt42/Render', 10:20:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:20:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:20:00 INFO - 'HOME': '/Users/cltbld', 10:20:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:20:00 INFO - 'LOGNAME': 'cltbld', 10:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:00 INFO - 'MOZ_NO_REMOTE': '1', 10:20:00 INFO - 'NO_EM_RESTART': '1', 10:20:00 INFO - 'PAGER': '/bin/cat', 10:20:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:00 INFO - 'PWD': '/builds/slave/test', 10:20:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:20:00 INFO - 'SHELL': '/bin/bash', 10:20:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiyIbVqt60/Listeners', 10:20:00 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 10:20:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:20:00 INFO - 'USER': 'cltbld', 10:20:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:20:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:00 INFO - 'XPC_FLAGS': '0x0', 10:20:00 INFO - 'XPC_SERVICE_NAME': '0', 10:20:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:00 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)) 10:20:00 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)) 10:20:00 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)) 10:20:00 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)) 10:20:00 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)) 10:20:00 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)) 10:20:00 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)) 10:20:00 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)) 10:20:00 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)) 10:20:00 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)) 10:20:00 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)) 10:20:00 INFO - Cleaning up... 10:20:00 INFO - Return code: 0 10:20:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:00 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 0x10ac0ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac0d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb51b479a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e8d30>, '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 0x10a90fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9ddbe8>, '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.BXFEc4Pt42/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.GiyIbVqt60/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 10:20:00 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 10:20:00 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 10:20:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXFEc4Pt42/Render', 10:20:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:20:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:20:00 INFO - 'HOME': '/Users/cltbld', 10:20:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:20:00 INFO - 'LOGNAME': 'cltbld', 10:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:00 INFO - 'MOZ_NO_REMOTE': '1', 10:20:00 INFO - 'NO_EM_RESTART': '1', 10:20:00 INFO - 'PAGER': '/bin/cat', 10:20:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:00 INFO - 'PWD': '/builds/slave/test', 10:20:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:20:00 INFO - 'SHELL': '/bin/bash', 10:20:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiyIbVqt60/Listeners', 10:20:00 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 10:20:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:20:00 INFO - 'USER': 'cltbld', 10:20:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:20:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:00 INFO - 'XPC_FLAGS': '0x0', 10:20:00 INFO - 'XPC_SERVICE_NAME': '0', 10:20:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:20:00 INFO - Cleaning up... 10:20:00 INFO - Return code: 0 10:20:00 INFO - Running post-action listener: _resource_record_post_action 10:20:00 INFO - Running post-action listener: _start_resource_monitoring 10:20:00 INFO - Starting resource monitoring. 10:20:00 INFO - [mozharness: 2017-03-16 17:20:00.599593Z] Finished create-virtualenv step (success) 10:20:00 INFO - [mozharness: 2017-03-16 17:20:00.600573Z] Running install step. 10:20:00 INFO - Running pre-action listener: _resource_record_pre_action 10:20:00 INFO - Running main action method: install 10:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:00 INFO - Reading from file tmpfile_stdout 10:20:00 INFO - Detecting whether we're running mozinstall >=1.0... 10:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:20:00 INFO - Reading from file tmpfile_stdout 10:20:00 INFO - Output received: 10:20:00 INFO - Usage: mozinstall [options] installer 10:20:00 INFO - Options: 10:20:00 INFO - -h, --help show this help message and exit 10:20:00 INFO - -d DEST, --destination=DEST 10:20:00 INFO - Directory to install application into. [default: 10:20:00 INFO - "/builds/slave/test"] 10:20:00 INFO - --app=APP Application being installed. [default: firefox] 10:20:00 INFO - mkdir: /builds/slave/test/build/application 10:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:20:21 INFO - Reading from file tmpfile_stdout 10:20:21 INFO - Output received: 10:20:21 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:20:21 INFO - Running post-action listener: _resource_record_post_action 10:20:21 INFO - [mozharness: 2017-03-16 17:20:21.126255Z] Finished install step (success) 10:20:21 INFO - [mozharness: 2017-03-16 17:20:21.126417Z] Running run-tests step. 10:20:21 INFO - Running pre-action listener: _resource_record_pre_action 10:20:21 INFO - Running main action method: run_tests 10:20:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:20:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:20:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:20:21 INFO - 2017-03-16 10:20:21.141 screenresolution[1624:7344] starting screenresolution argv=screenresolution get 10:20:21 INFO - 2017-03-16 10:20:21.143 screenresolution[1624:7344] Display 0: 1600x1200x32@60 10:20:21 INFO - 2017-03-16 10:20:21.149 screenresolution[1625:7347] starting screenresolution argv=screenresolution list 10:20:21 INFO - Available Modes on Display 0 10:20:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:20:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:20:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:20:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:20:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:20:21 INFO - Intel Iris: 10:20:21 INFO - Chipset Model: Intel Iris 10:20:21 INFO - Type: GPU 10:20:21 INFO - Bus: Built-In 10:20:21 INFO - VRAM (Dynamic, Max): 1536 MB 10:20:21 INFO - Vendor: Intel (0x8086) 10:20:21 INFO - Device ID: 0x0a2e 10:20:21 INFO - Revision ID: 0x0009 10:20:21 INFO - Displays: 10:20:21 INFO - Display: 10:20:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:20:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:20:21 INFO - Display Serial Number: 1600x1200 60 10:20:21 INFO - Main Display: Yes 10:20:21 INFO - Mirror: Off 10:20:21 INFO - Online: Yes 10:20:21 INFO - Rotation: Supported 10:20:21 INFO - Return code: 0 10:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:20:21 INFO - Python 2.7.3 10:20:21 INFO - Return code: 0 10:20:21 INFO - grabbing minidump binary from tooltool 10:20:21 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')]} 10:20:21 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 0x10a9e8d30>, '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 0x10a90fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9ddbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:20:21 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 10:20:21 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 10:20:21 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 10:20:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:20:21 INFO - Return code: 0 10:20:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:20:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:20:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:20:21 INFO - ENV: RUST_BACKTRACE is now 1 10:20:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:20:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:20:21 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/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 10:20:21 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/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0274 --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 10:20:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXFEc4Pt42/Render', 10:20:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:20:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:20:21 INFO - 'HOME': '/Users/cltbld', 10:20:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:20:21 INFO - 'LOGNAME': 'cltbld', 10:20:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:20:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:21 INFO - 'MOZ_NO_REMOTE': '1', 10:20:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:20:21 INFO - 'NO_EM_RESTART': '1', 10:20:21 INFO - 'PAGER': '/bin/cat', 10:20:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:21 INFO - 'PWD': '/builds/slave/test', 10:20:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:20:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:20:21 INFO - 'RUST_BACKTRACE': '1', 10:20:21 INFO - 'SHELL': '/bin/bash', 10:20:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GiyIbVqt60/Listeners', 10:20:21 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 10:20:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:20:21 INFO - 'USER': 'cltbld', 10:20:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:20:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:21 INFO - 'XPC_FLAGS': '0x0', 10:20:21 INFO - 'XPC_SERVICE_NAME': '0', 10:20:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:20:21 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/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 10:20:21 INFO - mozversion application_buildid: 20170316084022 10:20:21 INFO - mozversion application_changeset: 77fdb54e3df6e491aaf66ee6bc1f3aa8edba3367 10:20:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:20:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:20:21 INFO - mozversion application_name: Firefox 10:20:21 INFO - mozversion application_remotingname: firefox-dev 10:20:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:20:21 INFO - mozversion application_vendor: Mozilla 10:20:21 INFO - mozversion application_version: 54.0a2 10:20:21 INFO - mozversion platform_buildid: 20170316084022 10:20:21 INFO - mozversion platform_changeset: 77fdb54e3df6e491aaf66ee6bc1f3aa8edba3367 10:20:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:20:21 INFO - mozversion platform_version: 54.0a2 10:20:21 INFO - using testdate: 1489684821 10:20:21 INFO - actual date: 1489684821 10:20:21 INFO - starting webserver on 'localhost:49241' 10:20:21 INFO - SUITE-START | Running 2 tests 10:20:21 INFO - TEST-START | dromaeo_css 10:20:21 INFO - operating with platform_type : mac_ 10:20:21 INFO - Initialising browser for dromaeo_css test... 10:20:21 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpAD9rWE/profile http://localhost:49241/getInfo.html) 10:20:24 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 10:20:24 INFO - PROCESS | 1635 | colorDepth:24 10:20:24 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 10:20:24 INFO - PROCESS | 1635 | __metrics 10:20:24 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:20:24 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:20:25 INFO - TEST-INFO | 1635: exit 0 10:20:25 INFO - Browser initialized. 10:20:25 INFO - Running cycle 1/1 for dromaeo_css test... 10:20:25 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpAD9rWE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:37 INFO - PROCESS | 1638 | RSS: Main: 214474752 10:20:37 INFO - PROCESS | 1638 | 10:23:42 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 10:23:44 INFO - PROCESS | 1638 | RSS: Main: 400621568 10:23:44 INFO - PROCESS | 1638 | 10:25:27 INFO - PROCESS | 1638 | ************************* 10:25:27 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 10:25:27 INFO - PROCESS | 1638 | 10:25:27 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:25:27 INFO - PROCESS | 1638 | Full stack: 10:25:27 INFO - PROCESS | 1638 | ************************* 10:26:46 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 10:26:47 INFO - PROCESS | 1638 | RSS: Main: 351567872 10:26:47 INFO - PROCESS | 1638 | 10:29:50 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 10:29:50 INFO - PROCESS | 1638 | RSS: Main: 334942208 10:29:50 INFO - PROCESS | 1638 | 10:32:53 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 10:32:53 INFO - PROCESS | 1638 | RSS: Main: 323813376 10:32:53 INFO - PROCESS | 1638 | 10:35:57 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:35:58 INFO - PROCESS | 1638 | RSS: Main: 316538880 10:35:58 INFO - PROCESS | 1638 | 10:39:01 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:39:02 INFO - PROCESS | 1638 | RSS: Main: 452587520 10:39:02 INFO - PROCESS | 1638 | 10:39:02 INFO - PROCESS | 1638 | __start_tp_report 10:39:02 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 10:39:02 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 10:39:02 INFO - PROCESS | 1638 | |i|pagename|runs| 10:39:02 INFO - PROCESS | 1638 | |0;dojo.html;2679.557872950963;3384.560007199064;3396.966030339696;3401.5237866698653;3448.9310213795725;5903.645781253123;5944.881102377961;5980.79067232647;5981.5812893097445;5998.82003539894;5253.185756207784;5795.739191736371;5969.88060238795;6032.336442991267;6032.457078862902;5336.77254231527;5386.757595908193;5394.865128371783;5414.133738601825;5521.365043020044;5309.787608495655;5311.389190243133;5346.705931173784;5485.780568777264;5490.588205884555;5361.946380536184;5387;5394;5396.10964190908;5400.486953739389;5381.300430943972;5382.085045542228;5390.8921821563745;5397.163439666839;5401.756920938567;5228.320318358589;5344.438833922421;5347.51872331492;5361.035013697572;5392.325959255093;6047.334793172748;6048.941435248814;6050.667213303311;6051.636901785907;6059.21230240066;6134.693714559538;6161.106639537242;6161.507079433634;6161.7535298588;6169.2288463942;6248.250209974786;6252;6254.936660767635;6335.778247761306;6360;6056.303525094582;6121.724522396503;6122.571420000601;6129.877402451926;6140.969295153495;6144.463884028993;6552.705128269239;6553.377429144271;6574.441172500343;6577;6072.908906366408;6142.85000249909;6155.984262596711;6160.921838678213;6179.752809887644;6105.399096011559;6134.938650613526;6139.909912151923;6182.814515564541;6195.566310358232;6263.6241825490615;6266.655333956676;6267.2479302484;6276.466500347522;6289.685515724195;6278.30938596754;6281.309056003836;6283.96858015707;6286.748530058838;6287.1198032275515;4962.751862406865;5091.821786237464;5095.643304968617;5123.8719032023755;5170.379554453414;4491.6631252655525;4523.2988886722615;4532.048269863366;4547.113312903952;4549.135664223787;5819.039858423313;5821.446962538552;5828.475437210672;5828.59199856006;5833.533317334603;6093.842169987688;6259.1550140730415;6281.623102613858;6285.465735412541;6293.433590976742;5969.358691198366;5988.760449582055;5998;6008.819735407945;6026.6986650667295;5623.212750214973;5630.943690563124;5641.8589535261945;5641.887162256732;5642.6614403135945;6254.6247225166635;6582.736690532325;6587.308332625101;6594.4724422045165;6605.273419923805;6254.843628909131;6262.718177682106;6276.435120839146;6278.340774218641;6302.590331628429;6378.553501254868;6384.6169229846355;6391.456726178327;6445.323241059808;6463.612183269019;6292.18201633803;6293.433590976834;6301.905471418024;6308.936910630835;6324.177856878577;6339.90490142639;6350.460210882126;6351.9047214290895;6352.96823515898;6365.777197798055;6131.0708424985305;6145.446909777963;6313.55805093639;6318.747250110128;6318.778842740482;5463.153211252262;5781.219535362672;6080.48315893154;6243;6259.436650701458;6243.250809902841;6244.594101383395;6248.343923888108;6261.874762504815;6280.968595157177;6280.371962803683;6289.716962736779;6302.810915672537;6309.684515774101;6318.178636777189;5990.820275391745;6035.094735789491;6124.785632502841;6127.080937859357;6136.5090792737365 10:39:02 INFO - PROCESS | 1638 | |1;ext.html;755.5126943121687;793.8809178623208;820.3765138494745;887.9999999999995;899.424368404221;26232;39390.60609393905;39956.80021599892;39974.40038399426;40062.19875602493;40832.79583602085;40964;41105.58894411055;41220;41381.58618413815;7496.550206987571;9193.034731353195;9364.34449588529;9369.812603747921;9376.671816486425;7428.628568571577;7524.699012039539;7529.548227106364;7529.774106776778;7532.322091011808;10958.616448424307;11207.327560346364;11232.269902456314;11288.604898828542;11312.547498100066;11055.944720276388;11113.666590002313;11121.888781112166;11125.109991200725;11134.27627204229;7255.056842610426;10771.78456430867;10831.133509319236;10851.186161037875;10854.511546980404;27759.861200693867;27942.441151177067;28019.43961120766;28095.57856632152;37915;3699.5930447650735;3880.6935495907915;3886.2227554489214;3894.805259737002;3921.4706014687936;24192.395190120213;24223.031078756827;24237.63643545348;24400.51198976028;24935.877885495196;2993.4462124507036;3133.8861972277514;3160.336329370812;3162.256869635634;3273.06717585487;314225.4288728565;314683.4265828679;315148.8485115165;315237;315314.4234278837;44720.55279447229;44787.55212447834;44800.77599611981;44816.74240947105;44886.32670509945;46349.536504634525;46356.7682161587;46365.30452043222;46401;46430;13904.443822246996;14056.367463464168;14059.578212653636;14067.648308792363;14093.506727264497;12003.699907502383;12012.099092568093;12015.519379224734;12017.699557511132;12037;9468.763280917894;10317.071463568314;10465.476726163814;11988;12085;4681.226035390196;4976.954839483677;5623.437656234344;5712.457316554921;5712.600117991784;1067.6103222323952;1112.3548341961643;1120.8094623913955;1127.9774404511863;1166.288563975974;26569;26592.68167324502;26623;26755.464890702468;26826.86586567055;1239.975200496003;1245.9688507787378;1246.6322434881731;1287.1440492072668;1287.3434548380394;13707.794383084261;13877.722445551033;13916.721665566633;13940.163590184622;13977.301134943213;468319;471962;472684;472886;473710;55452;55766.72116639472;55860;55918.720406397704;55941.160882586795;1417.2276109520337;1465.6189390758266;1465.8680718735152;1466.2888499078151;1469.390203065737;24844.627330589694;25295.494090118464;25697.8883378666;26088;26090.478190436465;39832.2033559333;39930.80034599808;39961.60038399695;39974.20051598894;40072.79781606556;433473.83263084746;433709;434046;434209;434340;30999.380012400077;31491.52762708607;31699.841500792347;31708.524372134896;31726.206844829063;41991.7900410496;42177.36733948932;42857.57142428536;43163;44128;28448.715512844607;35383.29233415369;35498;35500.289994199455;36675;30870.69129308678;34982.65017349896;35040.64959350476;36276.45585316275;36300.63699362973;34593.65406345904;35225;35890.64109358873;35960.64039359573;36107.27785444224;30028.94898678536;31534.053978380685;31543.84228078845;31717.524237136;31718;23009.309720708407;23992.40018999539;24175.758242417352;24489.632655510537;24507.63238551459 10:39:02 INFO - PROCESS | 1638 | |2;jquery.html;384.09737117773255;401.3157566349375;416.4939598387959;424.54785653279254;444.06967403290116;13316.533921312755;21068.367948961535;21193.470163245926;21610.783892161075;21811.3456596302;22088;22125.66811497829;22559;23207.955641996108;23480.64779028316;6734.292899245582;6823.692933817965;6894.689738961759;6965.930340696605;7030.367266945974;4225.260579398593;6756.864862702743;6899.275576064516;6903.1371078615175;6903.861922761542;4399.2521271383785;4627.629789616823;7935.880961785549;7972.681092756283;7978;7653.1964143764935;7873.370130389555;7924.643391047417;7968.960155199187;7975.2423519765525;6896.620685862275;7241.420686345133;7728.26581474759;7749.883751743729;7763.883541746878;21774.346769596938;26044;26249.73750262511;26250.212493625222;26340.868295658398;3248.171716212351;3266.395716792401;3369.848356823949;3382.255903701182;3402.795832250048;15699.921500392426;15752.1336326502;15770.526884193492;15884.444044458389;16376;1846.510674671213;2011.4870707969521;2029.8985050747551;2065.4216819290623;2073.98963005184;133661;140558.29720851433;142212.28893855464;146391;146693;17117.517959895744;21203.787962120183;23356.532869342518;23439.765602344098;24049.398765031016;36862.631373686454;42708.572914271084;43318.35022474665;44240.77879610646;44339.77830110829;11488.885111148782;11554.191206615624;11631.709207269885;11661.766764664659;11800.70498237551;7819;9270.860937085949;9293.070692930653;9297.861491856776;9449.811003779885;10038.749031274276;10318.535665895053;10377;10954.672904202795;11357.37534435614;4345.456817897762;4527.47933987589;4584.266517357207;4596.402467679247;4601.44782626087;923.4413180025988;1023.8976102389702;1027.9023492768174;1041.8749750030045;1067.3755852826027;19116.522086947938;22464.76443795607;22922.19772307961;22933.08267669308;22942.541149176923;1003.6085926488676;1030.8506015792339;1042.135027926834;1049.800537897797;1051.7107795356185;9903.316436205718;10788.784224315626;11388.37363944991;11786.528538858349;11797.764044719057;679406.2059379442;685999;721485;750806;766268.5059724109;158590;159259;159277;162426;163463;1211.2248161176854;1242.5961562492225;1260.861305256421;1263.696712788924;1266.4301064521003;19093.272990730507;20114.89942550278;20148.899255503628;20166.899165504077;20202.797972020093;64737.02894456681;65019;66219.34451638747;66377;66566.66716666386;89799.10200898169;90357.19285614119;90411.64382534135;92073;92446.68883277972;10686.465676716289;11814.822777658514;11914.225575337576;11959.461824217757;12250.509979601073;11596.94201528987;11607.30356178632;11713.648590542298;12020.519179232733;12028.578999734968;10816.67549973502;11487.712807179887;11535.942320288344;11583.420828958688;11855.525778968744;11002.064824490008;11167.720806979565;11360.431978401211;11547.463721203563;11599;11585.478653460446;11833.526658933546;11872.940635296769;11877.58428455;11928.463219155332;11584.47869845842;11790.174687771774;11798.34823124746;11936.76126477483;12124.818127727915;11234.494447749707;11263.718407039889;11417.771644567229;11499.252548584314;11634.592789252674 10:39:02 INFO - PROCESS | 1638 | |3;mootools.html;1253.8119282107684;1413.491143188452;1442.502336693841;1443.54528323578;1448.7971683964247;10743.78512429751;11390.544378224871;11393.48729307181;11406.315621062731;11417.828732568998;10746;11163.386013769239;11189.44052797359;11305.491252893618;11322.886771132286;2403.0507949360035;2438.1344622658967;2438.9756102439014;2440.5851005329046;2450.681411416522;2010.115549158373;2044.5501989562347;2346.601077816775;2408.722996855358;2410.602250628644;2084.6247675418417;2105.3789132206034;2305.0894896515865;2388.8088952883813;2388.916387926423;2375.275540960015;2377.738448770634;2382.213869423086;2384.4277373430336;2385.2248019393764;2302.3323236261463;2384.9284521464383;2389.139909632531;2394.473215892501;2394.4971555973266;11130.554777808959;11241.718957026058;11246.437678116143;11249;11252.943735281353;5711.400302968212;5895.941040589625;5910.704464776744;5910.734016969203;5915.615484993462;3343.3814744272386;3425.075229687995;3673.559172899269;3683;3690.280395322913;1183.2545496337339;1223.149910811986;1767.8762486625942;1805.5756897129163;1928.1708865187964;15053.849461505355;15416.691666166726;15474.22628868552;15700.37198512058;15733.056016639039;4646.465656449552;4708.973519960111;4713.74074425903;4833.492483289204;4850.587700045536;11513.597024104283;11518.712032199262;11527.193096483166;11530.077593792477;11555.364454955059;5786.3056433228285;5798.10129429939;5802.448767367094;5804.303483581997;5818.185454036438;5041.8487445376695;5250.264962905197;5305.230741542532;5317.096093664087;5324.653897496651;3815.637514436124;3879.2047630236298;3912.6478616924614;3958.841646334172;3971.821268042945;913.8263729891299;1037.201354956694;1040.5161599856103;1054.362110922896;1055.6991257491577;601.7472661482188;636.5130675033603;782.4757412533617;795.1531618826048;828.3787159630277;5459.481349271813;5468.179773034077;6175.166352542439;6346.682665866781;6545.312742162099;917.4128557723062;917.6237742525666;948.2271948362063;982.872226610536;1039.5581877701945;4367.847125350598;4424.34685604436;4457.086297309044;4630.32860235264;4642.698224615389;13745.656358591115;14040.157590544395;14043.929780351236;14058.156510609191;14059.578212653636;12053.337066461429;12980.610581682564;13077.934610327078;13718.588442346745;13949.511767088103;10118.949405253074;10423.635172768916;10444.947775261075;10446.216533759998;10469.790604187874;5926.436988486087;6577.868442631217;6734.629595372302;6793.5244532882225;6873.621950792754;12165.33090680021;12203.633890983285;12219.26684398939;12293.139480236656;12484.375781211085;12464.002879769778;12473.750524989631;12655;12838;12865.356732163167;7562.621868906643;9213.12475314844;9251.814963700823;9420.199283060743;9485.098915603006;10152.137068349273;10236.33463824849;10347.896521034694;10372.377657340583;10401.375917444977;9108.863367049633;9138.360314777901;9219.585118669542;9222.44665320083;9226.907730922605;8882.200601945857;8987.101289870961;9060.54697265121;9122.95086065111;9143.451392916446;6462.127612772404;6753.581747832814;7304.707811687473;7353.558786472829;7882.605869706606;5442.183672449164;5471.480209380103;5501.477359650827;5611.663300202001;5746.511546518425;5627.380988091389;5651.124075768098;5816.796412125555;5918.23063001807;5935.821925342247 10:39:02 INFO - PROCESS | 1638 | |4;prototype.html;358.44083230160936;360.86647940262105;371.51517269962704;372.9533808273966;386.83559487217934;4491.8321236478505;4518.593326600605;4909.459959404468;5110.693358398494;5181.637285390024;4369.912601747963;4609.492955774862;4833.516648335165;5063.4177069637;5115.846524604259;3838.794606503573;4043.9595604044025;4200.51694055183;4257.084726783741;4294.742315461074;4044.5753195914444;4066.9389959150635;4302.827886884521;4310.97844510777;4356.867214524231;3572.8392222349926;3601.2977469393477;4166.583341665824;4366.956330436703;4386.473623165225;3743.513343265358;3798.6961043116485;3966.861159859391;4040.5959404059654;4368.453943257093;3539.929201415983;3630.7458477906557;3864.7294689371756;3941.2905676978135;3944.861929832442;3959.7925680199132;4255.361695745632;4283.400323954649;4434.578715022068;4564.406627138451;4467.530909254547;4809.350737650442;4912.435069966964;4927.802887884481;4935.679180853269;4861.416630004387;5029.245613158019;5378.892422151535;5563.276774019392;5582.720863956826;3971.6028397160344;4235.894102647459;4357.477102747659;4419.734815911055;4419.867403977886;5532.28080349556;5564.520560948476;5644.475991482318;5781.421857814227;5882.6764527950945;3743.0907678954723;4406.933895991563;4507.774611269423;4536.776979280195;4545.068345953023;4266.863855066524;4606.723596584216;4614.630829533629;4619.976900115478;4640.883977900579;4506.355180359145;4557.794899229542;4647.58171764536;4896.632752543574;4940.728259945666;4955;5025.623078269145;5098;5555.444455554412;5576.330840299109;1408.8520705325998;1409.6616811965055;1458.5478501664518;1464.1068947941747;1499.2503748125937;1015.5836107196014;1070.464767616192;1148.2019996102629;1155.5435602936793;1184.5202692909386;4611.354410382549;5089.312942752755;5096.700341412916;5133.409657889316;5153.891913238672;5115.565176959925;5277.445868183785;5312.634239418216;5328.8276579152525;5389.0299746046085;4637;4687.812487500461;4947.282644016597;5071.290019397287;5143.8456846294675;2778.624885640453;2967.442092901244;2971.5097008993707;2981.3142977115385;2990.489802649648;5685.891251206058;5777.277840269966;5986.491148252448;6003.979323514925;6036.667983260875;4904.60763138948;5335.626506144533;5353.86615334612;5467.4532546745;5883.499707574541;5083.051829938627;5414.35027796667;5969.403059693996;5989.143365556692;5995.430434108753;4982.800687972441;5015.749212539431;5537.363203231519;5785.190073389813;5793.478586927196;5172.5603323716405;5410.212851004391;5441.782328706808;5504.669719816664;5654.547636189012;4922.852314430573;5164.845054648366;5576.6299322786845;5876.3536011039605;5965.582409231486;3650.9594765491706;4083.8570650027104;4365.847195348148;4436.667249956331;4494.932576011297;4752.120857641347;5736.4550367715;5751.252337196138;5762.654240745401;5800.477956983892;4415.470143582791;4927.704337739747;5221.791128354976;5570.10616390413;5609.607327487037;5236.89526209466;5542.861428464321;5560.748831512878;5595.216669666169;5631.607346269916;4746.525347465225;4972.403311602631;5393.946060539344;5438.6192966493545;5477.75350109254;4647.4439058517;4660.300954856663;5499.312585926759;5538.6399884007415;5603.187537807076;4918.631102667386;5156.9428267205885;5431.79036246896;5447.455254474521;5494.8735509221315 10:39:02 INFO - PROCESS | 1638 | |5;yui.html;711.686857782576;734.0457405373018;776.6543887969852;817.7546735979207;825.7605294464605;14181.503647372345;14872.925635371808;14880.776788348183;14917.328720207603;14925.029873058258;11524.423778811048;13680.931595342034;13684.794728079087;13740.381682824273;13750.037497375188;871.2072014466836;893.5889490834224;895.6596493332524;896.3814967672317;922.137801155918;934.4813628436215;944.4616568555925;948.615810596706;954.0840792838883;954.7994921066585;999.6201443451479;1000.6297669862162;1001.4341896828305;1002.3634991780199;1003.909648131668;994.5176589354157;995.2336700740461;996.3772642098688;998.475800204891;999.635133176389;740.551966060531;741.6921977379382;742.6138408027796;743.379278302618;743.4498471131378;14852.33164507589;14912.70174596502;15167.848321516754;15300.846991530054;15402.152881591508;13028.869711302861;13250.271235082068;13386.129901556367;13444.126131801402;13512.662183445493;10215.540300686487;11220.531483073792;11367.488463019185;11543.74850585706;11860.703482412922;3522.295540891832;3553.1650062235353;3656.8902932912056;3714.9783809452347;3784.8864534064023;109491;113285;113331;113582;116558.41720791426;9764;9990.800183996425;10125.898741012496;10285.177185825116;10407.53166107527;21241;21360.35918922435;21669.67495487569;21687.34937951864;21730.78269217319;6671.666416679147;7359.153697324769;7417.666205020679;7465.514741541782;7489.625518724042;4176.83292668296;4191.685623578243;4249.80875860587;4414;4448.977755111204;3314.668533146666;3404.131946353664;3412.19813343864;3414.812185329781;3431.4338134208074;597.9312379076462;619.4765423217374;632.8512799492115;636.4939872801134;642.6369101457661;550.8044644151348;674.8717743628695;687.5977553131374;689.9379055884995;700.6846918886522;9993.512002794772;9999.450030248261;10184.796304073878;10222.028907253947;10245.538950747085;680.6766785776716;688.8243497908002;709.3474003916409;717.7846646006177;720.3948831211133;4120.649744771668;4145.709800313949;4206.831726730958;4284.485861696617;4362.912741745147;111401;114363;114421;115213;115262;97173.5141324303;98606.50696746471;99078.5046074765;99195.00804992003;101163.98836011693;62790;76771.08072298125;77870.61064694753;77994;80681.596592019;7957.56233407145;8072.717454889051;8075.192480752113;8137.715179968673;8147;45761.08477830491;46018.76990615026;52171.47828521818;53310.73344633252;54676.17985730138;63802.652456364565;70252.64873675599;70535.29464705287;71324.28675713176;71961;12194.817077743663;12207.877921220674;12689.302088385228;12768.634656866469;12785.48858045705;14134.646633834236;14417.207053611732;14583;14764.48324308644;15346.846531534988;12399.690007749878;12509.687257818627;13520.053596248561;13726.588202353945;13857.653558661113;13128.671783205114;13559.254241016839;13726.176429414267;13901.16593004423;14147.415614430334;10883.78232435331;12902.935485322514;13264.535741249396;13904.860951390356;14024.579262622137;10867.510962006887;10874.619388321371;11309.604163854226;11688.415579220835;11731.530738770354;9869.802603947737;10069.345492542961;11201.775964480501;11252.493637786156;11310.94344528272 10:39:02 INFO - PROCESS | 1638 | __end_tp_report 10:39:02 INFO - PROCESS | 1638 | __start_cc_report 10:39:02 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1948 10:39:02 INFO - PROCESS | 1638 | __end_cc_report 10:39:02 INFO - PROCESS | 1638 | __startTimestamp1489685942256__endTimestamp 10:39:02 INFO - PROCESS | 1638 | 10:39:02 INFO - PROCESS | 1638 | ------- Summary: start ------- 10:39:02 INFO - PROCESS | 1638 | Number of tests: 6 10:39:02 INFO - PROCESS | 1638 | 10:39:02 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5876.91 Median:6127.08 stddev:653.98 (10.7%) stddev-sans-first:605.98 10:39:02 INFO - PROCESS | 1638 | Values: 2679.6 3384.6 3397.0 3401.5 3448.9 5903.6 5944.9 5980.8 5981.6 5998.8 5253.2 5795.7 5969.9 6032.3 6032.5 5336.8 5386.8 5394.9 5414.1 5521.4 5309.8 5311.4 5346.7 5485.8 5490.6 5361.9 5387.0 5394.0 5396.1 5400.5 5381.3 5382.1 5390.9 5397.2 5401.8 5228.3 5344.4 5347.5 5361.0 5392.3 6047.3 6048.9 6050.7 6051.6 6059.2 6134.7 6161.1 6161.5 6161.8 6169.2 6248.3 6252.0 6254.9 6335.8 6360.0 6056.3 6121.7 6122.6 6129.9 6141.0 6144.5 6552.7 6553.4 6574.4 6577.0 6072.9 6142.9 6156.0 6160.9 6179.8 6105.4 6134.9 6139.9 6182.8 6195.6 6263.6 6266.7 6267.2 6276.5 6289.7 6278.3 6281.3 6284.0 6286.7 6287.1 4962.8 5091.8 5095.6 5123.9 5170.4 4491.7 4523.3 4532.0 4547.1 4549.1 5819.0 5821.4 5828.5 5828.6 5833.5 6093.8 6259.2 6281.6 6285.5 6293.4 5969.4 5988.8 5998.0 6008.8 6026.7 5623.2 5630.9 5641.9 5641.9 5642.7 6254.6 6582.7 6587.3 6594.5 6605.3 6254.8 6262.7 6276.4 6278.3 6302.6 6378.6 6384.6 6391.5 6445.3 6463.6 6292.2 6293.4 6301.9 6308.9 6324.2 6339.9 6350.5 6351.9 6353.0 6365.8 6131.1 6145.4 6313.6 6318.7 6318.8 5463.2 5781.2 6080.5 6243.0 6259.4 6243.3 6244.6 6248.3 6261.9 6281.0 6280.4 6289.7 6302.8 6309.7 6318.2 5990.8 6035.1 6124.8 6127.1 6136.5 10:39:02 INFO - PROCESS | 1638 | 10:39:02 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:53987.44 Median:31713.02 stddev:109514.06 (345.3%) stddev-sans-first:109748.35 10:39:02 INFO - PROCESS | 1638 | Values: 755.5 793.9 820.4 888.0 899.4 26232.0 39390.6 39956.8 39974.4 40062.2 40832.8 40964.0 41105.6 41220.0 41381.6 7496.6 9193.0 9364.3 9369.8 9376.7 7428.6 7524.7 7529.5 7529.8 7532.3 10958.6 11207.3 11232.3 11288.6 11312.5 11055.9 11113.7 11121.9 11125.1 11134.3 7255.1 10771.8 10831.1 10851.2 10854.5 27759.9 27942.4 28019.4 28095.6 37915.0 3699.6 3880.7 3886.2 3894.8 3921.5 24192.4 24223.0 24237.6 24400.5 24935.9 2993.4 3133.9 3160.3 3162.3 3273.1 314225.4 314683.4 315148.8 315237.0 315314.4 44720.6 44787.6 44800.8 44816.7 44886.3 46349.5 46356.8 46365.3 46401.0 46430.0 13904.4 14056.4 14059.6 14067.6 14093.5 12003.7 12012.1 12015.5 12017.7 12037.0 9468.8 10317.1 10465.5 11988.0 12085.0 4681.2 4977.0 5623.4 5712.5 5712.6 1067.6 1112.4 1120.8 1128.0 1166.3 26569.0 26592.7 26623.0 26755.5 26826.9 1240.0 1246.0 1246.6 1287.1 1287.3 13707.8 13877.7 13916.7 13940.2 13977.3 468319.0 471962.0 472684.0 472886.0 473710.0 55452.0 55766.7 55860.0 55918.7 55941.2 1417.2 1465.6 1465.9 1466.3 1469.4 24844.6 25295.5 25697.9 26088.0 26090.5 39832.2 39930.8 39961.6 39974.2 40072.8 433473.8 433709.0 434046.0 434209.0 434340.0 30999.4 31491.5 31699.8 31708.5 31726.2 41991.8 42177.4 42857.6 43163.0 44128.0 28448.7 35383.3 35498.0 35500.3 36675.0 30870.7 34982.7 35040.6 36276.5 36300.6 34593.7 35225.0 35890.6 35960.6 36107.3 30028.9 31534.1 31543.8 31717.5 31718.0 23009.3 23992.4 24175.8 24489.6 24507.6 10:39:02 INFO - PROCESS | 1638 | 10:39:02 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:42847.30 Median:11571.18 stddev:120505.83 (1041.4%) stddev-sans-first:120801.70 10:39:02 INFO - PROCESS | 1638 | Values: 384.1 401.3 416.5 424.5 444.1 13316.5 21068.4 21193.5 21610.8 21811.3 22088.0 22125.7 22559.0 23208.0 23480.6 6734.3 6823.7 6894.7 6965.9 7030.4 4225.3 6756.9 6899.3 6903.1 6903.9 4399.3 4627.6 7935.9 7972.7 7978.0 7653.2 7873.4 7924.6 7969.0 7975.2 6896.6 7241.4 7728.3 7749.9 7763.9 21774.3 26044.0 26249.7 26250.2 26340.9 3248.2 3266.4 3369.8 3382.3 3402.8 15699.9 15752.1 15770.5 15884.4 16376.0 1846.5 2011.5 2029.9 2065.4 2074.0 133661.0 140558.3 142212.3 146391.0 146693.0 17117.5 21203.8 23356.5 23439.8 24049.4 36862.6 42708.6 43318.4 44240.8 44339.8 11488.9 11554.2 11631.7 11661.8 11800.7 7819.0 9270.9 9293.1 9297.9 9449.8 10038.7 10318.5 10377.0 10954.7 11357.4 4345.5 4527.5 4584.3 4596.4 4601.4 923.4 1023.9 1027.9 1041.9 1067.4 19116.5 22464.8 22922.2 22933.1 22942.5 1003.6 1030.9 1042.1 1049.8 1051.7 9903.3 10788.8 11388.4 11786.5 11797.8 679406.2 685999.0 721485.0 750806.0 766268.5 158590.0 159259.0 159277.0 162426.0 163463.0 1211.2 1242.6 1260.9 1263.7 1266.4 19093.3 20114.9 20148.9 20166.9 20202.8 64737.0 65019.0 66219.3 66377.0 66566.7 89799.1 90357.2 90411.6 92073.0 92446.7 10686.5 11814.8 11914.2 11959.5 12250.5 11596.9 11607.3 11713.6 12020.5 12028.6 10816.7 11487.7 11535.9 11583.4 11855.5 11002.1 11167.7 11360.4 11547.5 11599.0 11585.5 11833.5 11872.9 11877.6 11928.5 11584.5 11790.2 11798.3 11936.8 12124.8 11234.5 11263.7 11417.8 11499.3 11634.6 10:39:02 INFO - PROCESS | 1638 | 10:39:02 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:6742.06 Median:2424.37 stddev:4265.14 (175.9%) stddev-sans-first:4257.16 10:39:02 INFO - PROCESS | 1638 | Values: 1253.8 1413.5 1442.5 1443.5 1448.8 10743.8 11390.5 11393.5 11406.3 11417.8 10746.0 11163.4 11189.4 11305.5 11322.9 2403.1 2438.1 2439.0 2440.6 2450.7 2010.1 2044.6 2346.6 2408.7 2410.6 2084.6 2105.4 2305.1 2388.8 2388.9 2375.3 2377.7 2382.2 2384.4 2385.2 2302.3 2384.9 2389.1 2394.5 2394.5 11130.6 11241.7 11246.4 11249.0 11252.9 5711.4 5895.9 5910.7 5910.7 5915.6 3343.4 3425.1 3673.6 3683.0 3690.3 1183.3 1223.1 1767.9 1805.6 1928.2 15053.8 15416.7 15474.2 15700.4 15733.1 4646.5 4709.0 4713.7 4833.5 4850.6 11513.6 11518.7 11527.2 11530.1 11555.4 5786.3 5798.1 5802.4 5804.3 5818.2 5041.8 5250.3 5305.2 5317.1 5324.7 3815.6 3879.2 3912.6 3958.8 3971.8 913.8 1037.2 1040.5 1054.4 1055.7 601.7 636.5 782.5 795.2 828.4 5459.5 5468.2 6175.2 6346.7 6545.3 917.4 917.6 948.2 982.9 1039.6 4367.8 4424.3 4457.1 4630.3 4642.7 13745.7 14040.2 14043.9 14058.2 14059.6 12053.3 12980.6 13077.9 13718.6 13949.5 10118.9 10423.6 10444.9 10446.2 10469.8 5926.4 6577.9 6734.6 6793.5 6873.6 12165.3 12203.6 12219.3 12293.1 12484.4 12464.0 12473.8 12655.0 12838.0 12865.4 7562.6 9213.1 9251.8 9420.2 9485.1 10152.1 10236.3 10347.9 10372.4 10401.4 9108.9 9138.4 9219.6 9222.4 9226.9 8882.2 8987.1 9060.5 9123.0 9143.5 6462.1 6753.6 7304.7 7353.6 7882.6 5442.2 5471.5 5501.5 5611.7 5746.5 5627.4 5651.1 5816.8 5918.2 5935.8 10:39:02 INFO - PROCESS | 1638 | 10:39:02 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4541.65 Median:4907.03 stddev:1283.36 (26.2%) stddev-sans-first:1247.96 10:39:02 INFO - PROCESS | 1638 | Values: 358.4 360.9 371.5 373.0 386.8 4491.8 4518.6 4909.5 5110.7 5181.6 4369.9 4609.5 4833.5 5063.4 5115.8 3838.8 4044.0 4200.5 4257.1 4294.7 4044.6 4066.9 4302.8 4311.0 4356.9 3572.8 3601.3 4166.6 4367.0 4386.5 3743.5 3798.7 3966.9 4040.6 4368.5 3539.9 3630.7 3864.7 3941.3 3944.9 3959.8 4255.4 4283.4 4434.6 4564.4 4467.5 4809.4 4912.4 4927.8 4935.7 4861.4 5029.2 5378.9 5563.3 5582.7 3971.6 4235.9 4357.5 4419.7 4419.9 5532.3 5564.5 5644.5 5781.4 5882.7 3743.1 4406.9 4507.8 4536.8 4545.1 4266.9 4606.7 4614.6 4620.0 4640.9 4506.4 4557.8 4647.6 4896.6 4940.7 4955.0 5025.6 5098.0 5555.4 5576.3 1408.9 1409.7 1458.5 1464.1 1499.3 1015.6 1070.5 1148.2 1155.5 1184.5 4611.4 5089.3 5096.7 5133.4 5153.9 5115.6 5277.4 5312.6 5328.8 5389.0 4637.0 4687.8 4947.3 5071.3 5143.8 2778.6 2967.4 2971.5 2981.3 2990.5 5685.9 5777.3 5986.5 6004.0 6036.7 4904.6 5335.6 5353.9 5467.5 5883.5 5083.1 5414.4 5969.4 5989.1 5995.4 4982.8 5015.7 5537.4 5785.2 5793.5 5172.6 5410.2 5441.8 5504.7 5654.5 4922.9 5164.8 5576.6 5876.4 5965.6 3651.0 4083.9 4365.8 4436.7 4494.9 4752.1 5736.5 5751.3 5762.7 5800.5 4415.5 4927.7 5221.8 5570.1 5609.6 5236.9 5542.9 5560.7 5595.2 5631.6 4746.5 4972.4 5393.9 5438.6 5477.8 4647.4 4660.3 5499.3 5538.6 5603.2 4918.6 5156.9 5431.8 5447.5 5494.9 10:39:02 INFO - PROCESS | 1638 | 10:39:02 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:21069.14 Median:3537.73 stddev:31587.63 (892.9%) stddev-sans-first:31639.26 10:39:02 INFO - PROCESS | 1638 | Values: 711.7 734.0 776.7 817.8 825.8 14181.5 14872.9 14880.8 14917.3 14925.0 11524.4 13680.9 13684.8 13740.4 13750.0 871.2 893.6 895.7 896.4 922.1 934.5 944.5 948.6 954.1 954.8 999.6 1000.6 1001.4 1002.4 1003.9 994.5 995.2 996.4 998.5 999.6 740.6 741.7 742.6 743.4 743.4 14852.3 14912.7 15167.8 15300.8 15402.2 13028.9 13250.3 13386.1 13444.1 13512.7 10215.5 11220.5 11367.5 11543.7 11860.7 3522.3 3553.2 3656.9 3715.0 3784.9 109491.0 113285.0 113331.0 113582.0 116558.4 9764.0 9990.8 10125.9 10285.2 10407.5 21241.0 21360.4 21669.7 21687.3 21730.8 6671.7 7359.2 7417.7 7465.5 7489.6 4176.8 4191.7 4249.8 4414.0 4449.0 3314.7 3404.1 3412.2 3414.8 3431.4 597.9 619.5 632.9 636.5 642.6 550.8 674.9 687.6 689.9 700.7 9993.5 9999.5 10184.8 10222.0 10245.5 680.7 688.8 709.3 717.8 720.4 4120.6 4145.7 4206.8 4284.5 4362.9 111401.0 114363.0 114421.0 115213.0 115262.0 97173.5 98606.5 99078.5 99195.0 101164.0 62790.0 76771.1 77870.6 77994.0 80681.6 7957.6 8072.7 8075.2 8137.7 8147.0 45761.1 46018.8 52171.5 53310.7 54676.2 63802.7 70252.6 70535.3 71324.3 71961.0 12194.8 12207.9 12689.3 12768.6 12785.5 14134.6 14417.2 14583.0 14764.5 15346.8 12399.7 12509.7 13520.1 13726.6 13857.7 13128.7 13559.3 13726.2 13901.2 14147.4 10883.8 12902.9 13264.5 13904.9 14024.6 10867.5 10874.6 11309.6 11688.4 11731.5 9869.8 10069.3 11201.8 11252.5 11310.9 10:39:02 INFO - PROCESS | 1638 | -------- Summary: end -------- 10:39:02 INFO - PROCESS | 1638 | 10:39:02 INFO - TEST-INFO | 1638: exit 0 10:39:02 INFO - TEST-OK | dromaeo_css | took 1121222ms 10:39:02 INFO - TEST-START | kraken 10:39:02 INFO - operating with platform_type : mac_ 10:39:02 INFO - Initialising browser for kraken test... 10:39:02 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmp0jAsCJ/profile http://localhost:49241/getInfo.html) 10:39:05 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 10:39:05 INFO - PROCESS | 1648 | colorDepth:24 10:39:05 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 10:39:05 INFO - PROCESS | 1648 | __metrics 10:39:05 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:39:05 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:39:06 INFO - TEST-INFO | 1648: exit 0 10:39:06 INFO - Browser initialized. 10:39:06 INFO - Running cycle 1/1 for kraken test... 10:39:06 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmp0jAsCJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:18 INFO - PROCESS | 1649 | RSS: Main: 214777856 10:39:18 INFO - PROCESS | 1649 | 10:39:21 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:39:22 INFO - PROCESS | 1649 | RSS: Main: 267051008 10:39:22 INFO - PROCESS | 1649 | 10:39:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:39:25 INFO - PROCESS | 1649 | RSS: Main: 277180416 10:39:25 INFO - PROCESS | 1649 | 10:39:28 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:39:29 INFO - PROCESS | 1649 | RSS: Main: 374349824 10:39:29 INFO - PROCESS | 1649 | 10:39:31 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:39:32 INFO - PROCESS | 1649 | RSS: Main: 277377024 10:39:32 INFO - PROCESS | 1649 | 10:39:34 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:39:34 INFO - PROCESS | 1649 | RSS: Main: 278753280 10:39:34 INFO - PROCESS | 1649 | 10:39:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:39:38 INFO - PROCESS | 1649 | RSS: Main: 320278528 10:39:38 INFO - PROCESS | 1649 | 10:39:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:41 INFO - PROCESS | 1649 | RSS: Main: 322142208 10:39:41 INFO - PROCESS | 1649 | 10:39:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:39:45 INFO - PROCESS | 1649 | RSS: Main: 319094784 10:39:45 INFO - PROCESS | 1649 | 10:39:47 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:47 INFO - PROCESS | 1649 | RSS: Main: 295317504 10:39:47 INFO - PROCESS | 1649 | 10:39:49 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:50 INFO - PROCESS | 1649 | RSS: Main: 297476096 10:39:50 INFO - PROCESS | 1649 | 10:39:52 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:52 INFO - PROCESS | 1649 | RSS: Main: 305872896 10:39:52 INFO - PROCESS | 1649 | 10:39:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:39:56 INFO - PROCESS | 1649 | RSS: Main: 320430080 10:39:56 INFO - PROCESS | 1649 | 10:39:59 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:40:00 INFO - PROCESS | 1649 | RSS: Main: 313864192 10:40:00 INFO - PROCESS | 1649 | 10:40:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:40:02 INFO - PROCESS | 1649 | RSS: Main: 358711296 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | __start_tp_report 10:40:02 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 10:40:02 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 10:40:02 INFO - PROCESS | 1649 | |i|pagename|runs| 10:40:02 INFO - PROCESS | 1649 | |0;ai-astar;117;117;116;116;115;117;116;116;117;117 10:40:02 INFO - PROCESS | 1649 | |1;audio-beat-detection;141;110;113;168;135;128;108;106;130;109 10:40:02 INFO - PROCESS | 1649 | |2;audio-dft;187;185;184;188;183;186;183;183;183;186 10:40:02 INFO - PROCESS | 1649 | |3;audio-fft;83;65;81;113;60;62;59;60;75;59 10:40:02 INFO - PROCESS | 1649 | |4;audio-oscillator;86;68;86;70;69;68;83;69;67;85 10:40:02 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;87;87;87;87;87;87;88;86;87;87 10:40:02 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;94;106;153;94;93;93;98;94;94 10:40:02 INFO - PROCESS | 1649 | |7;imaging-desaturate;84;84;83;85;83;84;86;84;85;89 10:40:02 INFO - PROCESS | 1649 | |8;json-parse-financial;65;63;61;61;63;63;64;64;63;63 10:40:02 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;55;59;69;65;60;59;59;58;58;58 10:40:02 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;86;82;83;86;84;86;81;86;90;90 10:40:02 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;142;140;143;142;148;139;131;138;204;137 10:40:02 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;166;164;166;167;167;164;206;174;165;166 10:40:02 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;67;66;64;66;64;64;64;66;64;64 10:40:02 INFO - PROCESS | 1649 | __end_tp_report 10:40:02 INFO - PROCESS | 1649 | __start_cc_report 10:40:02 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2114 10:40:02 INFO - PROCESS | 1649 | __end_cc_report 10:40:02 INFO - PROCESS | 1649 | __startTimestamp1489686002174__endTimestamp 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | ------- Summary: start ------- 10:40:02 INFO - PROCESS | 1649 | Number of tests: 14 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:116.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 10:40:02 INFO - PROCESS | 1649 | Values: 117.0 117.0 116.0 116.0 115.0 117.0 116.0 116.0 117.0 117.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:129.00 stddev:19.76 (15.3%) stddev-sans-first:20.07 10:40:02 INFO - PROCESS | 1649 | Values: 141.0 110.0 113.0 168.0 135.0 128.0 108.0 106.0 130.0 109.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.50 stddev:1.87 (1.0%) stddev-sans-first:1.81 10:40:02 INFO - PROCESS | 1649 | Values: 187.0 185.0 184.0 188.0 183.0 186.0 183.0 183.0 183.0 186.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:71.70 Median:63.50 stddev:17.21 (27.1%) stddev-sans-first:17.76 10:40:02 INFO - PROCESS | 1649 | Values: 83.0 65.0 81.0 113.0 60.0 62.0 59.0 60.0 75.0 59.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.50 stddev:8.60 (11.2%) stddev-sans-first:8.16 10:40:02 INFO - PROCESS | 1649 | Values: 86.0 68.0 86.0 70.0 69.0 68.0 83.0 69.0 67.0 85.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:87.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:40:02 INFO - PROCESS | 1649 | Values: 87.0 87.0 87.0 87.0 87.0 87.0 88.0 86.0 87.0 87.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:94.00 stddev:18.59 (19.8%) stddev-sans-first:19.53 10:40:02 INFO - PROCESS | 1649 | Values: 94.0 94.0 106.0 153.0 94.0 93.0 93.0 98.0 94.0 94.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:84.50 stddev:1.77 (2.1%) stddev-sans-first:1.86 10:40:02 INFO - PROCESS | 1649 | Values: 84.0 84.0 83.0 85.0 83.0 84.0 86.0 84.0 85.0 89.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:1.25 (2.0%) stddev-sans-first:1.09 10:40:02 INFO - PROCESS | 1649 | Values: 65.0 63.0 61.0 61.0 63.0 63.0 64.0 64.0 63.0 63.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:59.00 stddev:4.03 (6.8%) stddev-sans-first:3.84 10:40:02 INFO - PROCESS | 1649 | Values: 55.0 59.0 69.0 65.0 60.0 59.0 59.0 58.0 58.0 58.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:3.03 (3.5%) stddev-sans-first:3.20 10:40:02 INFO - PROCESS | 1649 | Values: 86.0 82.0 83.0 86.0 84.0 86.0 81.0 86.0 90.0 90.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:142.00 stddev:20.72 (14.6%) stddev-sans-first:21.91 10:40:02 INFO - PROCESS | 1649 | Values: 142.0 140.0 143.0 142.0 148.0 139.0 131.0 138.0 204.0 137.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:166.50 stddev:12.79 (7.7%) stddev-sans-first:13.46 10:40:02 INFO - PROCESS | 1649 | Values: 166.0 164.0 166.0 167.0 167.0 164.0 206.0 174.0 165.0 166.0 10:40:02 INFO - PROCESS | 1649 | 10:40:02 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.00 10:40:02 INFO - PROCESS | 1649 | Values: 67.0 66.0 64.0 66.0 64.0 64.0 64.0 66.0 64.0 64.0 10:40:02 INFO - PROCESS | 1649 | -------- Summary: end -------- 10:40:02 INFO - PROCESS | 1649 | 10:40:03 INFO - TEST-INFO | 1649: exit 0 10:40:03 INFO - TEST-OK | kraken | took 60152ms 10:40:03 INFO - SUITE-END | took 1181s 10:40:03 INFO - Completed test suite (00:19:41) 10:40:03 INFO - javascript benchmark 10:40:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7669.422075493752, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2679.557872950963, 3384.560007199064, 3396.966030339696, 3401.5237866698653, 3448.9310213795725, 5903.645781253123, 5944.881102377961, 5980.79067232647, 5981.5812893097445, 5998.82003539894, 5253.185756207784, 5795.739191736371, 5969.88060238795, 6032.336442991267, 6032.457078862902, 5336.77254231527, 5386.757595908193, 5394.865128371783, 5414.133738601825, 5521.365043020044, 5309.787608495655, 5311.389190243133, 5346.705931173784, 5485.780568777264, 5490.588205884555, 5361.946380536184, 5387.0, 5394.0, 5396.10964190908, 5400.486953739389, 5381.300430943972, 5382.085045542228, 5390.8921821563745, 5397.163439666839, 5401.756920938567, 5228.320318358589, 5344.438833922421, 5347.51872331492, 5361.035013697572, 5392.325959255093, 6047.334793172748, 6048.941435248814, 6050.667213303311, 6051.636901785907, 6059.21230240066, 6134.693714559538, 6161.106639537242, 6161.507079433634, 6161.7535298588, 6169.2288463942, 6248.250209974786, 6252.0, 6254.936660767635, 6335.778247761306, 6360.0, 6056.303525094582, 6121.724522396503, 6122.571420000601, 6129.877402451926, 6140.969295153495, 6144.463884028993, 6552.705128269239, 6553.377429144271, 6574.441172500343, 6577.0, 6072.908906366408, 6142.85000249909, 6155.984262596711, 6160.921838678213, 6179.752809887644, 6105.399096011559, 6134.938650613526, 6139.909912151923, 6182.814515564541, 6195.566310358232, 6263.6241825490615, 6266.655333956676, 6267.2479302484, 6276.466500347522, 6289.685515724195, 6278.30938596754, 6281.309056003836, 6283.96858015707, 6286.748530058838, 6287.1198032275515, 4962.751862406865, 5091.821786237464, 5095.643304968617, 5123.8719032023755, 5170.379554453414, 4491.6631252655525, 4523.2988886722615, 4532.048269863366, 4547.113312903952, 4549.135664223787, 5819.039858423313, 5821.446962538552, 5828.475437210672, 5828.59199856006, 5833.533317334603, 6093.842169987688, 6259.1550140730415, 6281.623102613858, 6285.465735412541, 6293.433590976742, 5969.358691198366, 5988.760449582055, 5998.0, 6008.819735407945, 6026.6986650667295, 5623.212750214973, 5630.943690563124, 5641.8589535261945, 5641.887162256732, 5642.6614403135945, 6254.6247225166635, 6582.736690532325, 6587.308332625101, 6594.4724422045165, 6605.273419923805, 6254.843628909131, 6262.718177682106, 6276.435120839146, 6278.340774218641, 6302.590331628429, 6378.553501254868, 6384.6169229846355, 6391.456726178327, 6445.323241059808, 6463.612183269019, 6292.18201633803, 6293.433590976834, 6301.905471418024, 6308.936910630835, 6324.177856878577, 6339.90490142639, 6350.460210882126, 6351.9047214290895, 6352.96823515898, 6365.777197798055, 6131.0708424985305, 6145.446909777963, 6313.55805093639, 6318.747250110128, 6318.778842740482, 5463.153211252262, 5781.219535362672, 6080.48315893154, 6243.0, 6259.436650701458, 6243.250809902841, 6244.594101383395, 6248.343923888108, 6261.874762504815, 6280.968595157177, 6280.371962803683, 6289.716962736779, 6302.810915672537, 6309.684515774101, 6318.178636777189, 5990.820275391745, 6035.094735789491, 6124.785632502841, 6127.080937859357, 6136.5090792737365], "value": 5833.0383496759005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.5126943121687, 793.8809178623208, 820.3765138494745, 887.9999999999995, 899.424368404221, 26232.0, 39390.60609393905, 39956.80021599892, 39974.40038399426, 40062.19875602493, 40832.79583602085, 40964.0, 41105.58894411055, 41220.0, 41381.58618413815, 7496.550206987571, 9193.034731353195, 9364.34449588529, 9369.812603747921, 9376.671816486425, 7428.628568571577, 7524.699012039539, 7529.548227106364, 7529.774106776778, 7532.322091011808, 10958.616448424307, 11207.327560346364, 11232.269902456314, 11288.604898828542, 11312.547498100066, 11055.944720276388, 11113.666590002313, 11121.888781112166, 11125.109991200725, 11134.27627204229, 7255.056842610426, 10771.78456430867, 10831.133509319236, 10851.186161037875, 10854.511546980404, 27759.861200693867, 27942.441151177067, 28019.43961120766, 28095.57856632152, 37915.0, 3699.5930447650735, 3880.6935495907915, 3886.2227554489214, 3894.805259737002, 3921.4706014687936, 24192.395190120213, 24223.031078756827, 24237.63643545348, 24400.51198976028, 24935.877885495196, 2993.4462124507036, 3133.8861972277514, 3160.336329370812, 3162.256869635634, 3273.06717585487, 314225.4288728565, 314683.4265828679, 315148.8485115165, 315237.0, 315314.4234278837, 44720.55279447229, 44787.55212447834, 44800.77599611981, 44816.74240947105, 44886.32670509945, 46349.536504634525, 46356.7682161587, 46365.30452043222, 46401.0, 46430.0, 13904.443822246996, 14056.367463464168, 14059.578212653636, 14067.648308792363, 14093.506727264497, 12003.699907502383, 12012.099092568093, 12015.519379224734, 12017.699557511132, 12037.0, 9468.763280917894, 10317.071463568314, 10465.476726163814, 11988.0, 12085.0, 4681.226035390196, 4976.954839483677, 5623.437656234344, 5712.457316554921, 5712.600117991784, 1067.6103222323952, 1112.3548341961643, 1120.8094623913955, 1127.9774404511863, 1166.288563975974, 26569.0, 26592.68167324502, 26623.0, 26755.464890702468, 26826.86586567055, 1239.975200496003, 1245.9688507787378, 1246.6322434881731, 1287.1440492072668, 1287.3434548380394, 13707.794383084261, 13877.722445551033, 13916.721665566633, 13940.163590184622, 13977.301134943213, 468319.0, 471962.0, 472684.0, 472886.0, 473710.0, 55452.0, 55766.72116639472, 55860.0, 55918.720406397704, 55941.160882586795, 1417.2276109520337, 1465.6189390758266, 1465.8680718735152, 1466.2888499078151, 1469.390203065737, 24844.627330589694, 25295.494090118464, 25697.8883378666, 26088.0, 26090.478190436465, 39832.2033559333, 39930.80034599808, 39961.60038399695, 39974.20051598894, 40072.79781606556, 433473.83263084746, 433709.0, 434046.0, 434209.0, 434340.0, 30999.380012400077, 31491.52762708607, 31699.841500792347, 31708.524372134896, 31726.206844829063, 41991.7900410496, 42177.36733948932, 42857.57142428536, 43163.0, 44128.0, 28448.715512844607, 35383.29233415369, 35498.0, 35500.289994199455, 36675.0, 30870.69129308678, 34982.65017349896, 35040.64959350476, 36276.45585316275, 36300.63699362973, 34593.65406345904, 35225.0, 35890.64109358873, 35960.64039359573, 36107.27785444224, 30028.94898678536, 31534.053978380685, 31543.84228078845, 31717.524237136, 31718.0, 23009.309720708407, 23992.40018999539, 24175.758242417352, 24489.632655510537, 24507.63238551459], "value": 18208.416302116777, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.09737117773255, 401.3157566349375, 416.4939598387959, 424.54785653279254, 444.06967403290116, 13316.533921312755, 21068.367948961535, 21193.470163245926, 21610.783892161075, 21811.3456596302, 22088.0, 22125.66811497829, 22559.0, 23207.955641996108, 23480.64779028316, 6734.292899245582, 6823.692933817965, 6894.689738961759, 6965.930340696605, 7030.367266945974, 4225.260579398593, 6756.864862702743, 6899.275576064516, 6903.1371078615175, 6903.861922761542, 4399.2521271383785, 4627.629789616823, 7935.880961785549, 7972.681092756283, 7978.0, 7653.1964143764935, 7873.370130389555, 7924.643391047417, 7968.960155199187, 7975.2423519765525, 6896.620685862275, 7241.420686345133, 7728.26581474759, 7749.883751743729, 7763.883541746878, 21774.346769596938, 26044.0, 26249.73750262511, 26250.212493625222, 26340.868295658398, 3248.171716212351, 3266.395716792401, 3369.848356823949, 3382.255903701182, 3402.795832250048, 15699.921500392426, 15752.1336326502, 15770.526884193492, 15884.444044458389, 16376.0, 1846.510674671213, 2011.4870707969521, 2029.8985050747551, 2065.4216819290623, 2073.98963005184, 133661.0, 140558.29720851433, 142212.28893855464, 146391.0, 146693.0, 17117.517959895744, 21203.787962120183, 23356.532869342518, 23439.765602344098, 24049.398765031016, 36862.631373686454, 42708.572914271084, 43318.35022474665, 44240.77879610646, 44339.77830110829, 11488.885111148782, 11554.191206615624, 11631.709207269885, 11661.766764664659, 11800.70498237551, 7819.0, 9270.860937085949, 9293.070692930653, 9297.861491856776, 9449.811003779885, 10038.749031274276, 10318.535665895053, 10377.0, 10954.672904202795, 11357.37534435614, 4345.456817897762, 4527.47933987589, 4584.266517357207, 4596.402467679247, 4601.44782626087, 923.4413180025988, 1023.8976102389702, 1027.9023492768174, 1041.8749750030045, 1067.3755852826027, 19116.522086947938, 22464.76443795607, 22922.19772307961, 22933.08267669308, 22942.541149176923, 1003.6085926488676, 1030.8506015792339, 1042.135027926834, 1049.800537897797, 1051.7107795356185, 9903.316436205718, 10788.784224315626, 11388.37363944991, 11786.528538858349, 11797.764044719057, 679406.2059379442, 685999.0, 721485.0, 750806.0, 766268.5059724109, 158590.0, 159259.0, 159277.0, 162426.0, 163463.0, 1211.2248161176854, 1242.5961562492225, 1260.861305256421, 1263.696712788924, 1266.4301064521003, 19093.272990730507, 20114.89942550278, 20148.899255503628, 20166.899165504077, 20202.797972020093, 64737.02894456681, 65019.0, 66219.34451638747, 66377.0, 66566.66716666386, 89799.10200898169, 90357.19285614119, 90411.64382534135, 92073.0, 92446.68883277972, 10686.465676716289, 11814.822777658514, 11914.225575337576, 11959.461824217757, 12250.509979601073, 11596.94201528987, 11607.30356178632, 11713.648590542298, 12020.519179232733, 12028.578999734968, 10816.67549973502, 11487.712807179887, 11535.942320288344, 11583.420828958688, 11855.525778968744, 11002.064824490008, 11167.720806979565, 11360.431978401211, 11547.463721203563, 11599.0, 11585.478653460446, 11833.526658933546, 11872.940635296769, 11877.58428455, 11928.463219155332, 11584.47869845842, 11790.174687771774, 11798.34823124746, 11936.76126477483, 12124.818127727915, 11234.494447749707, 11263.718407039889, 11417.771644567229, 11499.252548584314, 11634.592789252674], "value": 12006.464683811171, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.8119282107684, 1413.491143188452, 1442.502336693841, 1443.54528323578, 1448.7971683964247, 10743.78512429751, 11390.544378224871, 11393.48729307181, 11406.315621062731, 11417.828732568998, 10746.0, 11163.386013769239, 11189.44052797359, 11305.491252893618, 11322.886771132286, 2403.0507949360035, 2438.1344622658967, 2438.9756102439014, 2440.5851005329046, 2450.681411416522, 2010.115549158373, 2044.5501989562347, 2346.601077816775, 2408.722996855358, 2410.602250628644, 2084.6247675418417, 2105.3789132206034, 2305.0894896515865, 2388.8088952883813, 2388.916387926423, 2375.275540960015, 2377.738448770634, 2382.213869423086, 2384.4277373430336, 2385.2248019393764, 2302.3323236261463, 2384.9284521464383, 2389.139909632531, 2394.473215892501, 2394.4971555973266, 11130.554777808959, 11241.718957026058, 11246.437678116143, 11249.0, 11252.943735281353, 5711.400302968212, 5895.941040589625, 5910.704464776744, 5910.734016969203, 5915.615484993462, 3343.3814744272386, 3425.075229687995, 3673.559172899269, 3683.0, 3690.280395322913, 1183.2545496337339, 1223.149910811986, 1767.8762486625942, 1805.5756897129163, 1928.1708865187964, 15053.849461505355, 15416.691666166726, 15474.22628868552, 15700.37198512058, 15733.056016639039, 4646.465656449552, 4708.973519960111, 4713.74074425903, 4833.492483289204, 4850.587700045536, 11513.597024104283, 11518.712032199262, 11527.193096483166, 11530.077593792477, 11555.364454955059, 5786.3056433228285, 5798.10129429939, 5802.448767367094, 5804.303483581997, 5818.185454036438, 5041.8487445376695, 5250.264962905197, 5305.230741542532, 5317.096093664087, 5324.653897496651, 3815.637514436124, 3879.2047630236298, 3912.6478616924614, 3958.841646334172, 3971.821268042945, 913.8263729891299, 1037.201354956694, 1040.5161599856103, 1054.362110922896, 1055.6991257491577, 601.7472661482188, 636.5130675033603, 782.4757412533617, 795.1531618826048, 828.3787159630277, 5459.481349271813, 5468.179773034077, 6175.166352542439, 6346.682665866781, 6545.312742162099, 917.4128557723062, 917.6237742525666, 948.2271948362063, 982.872226610536, 1039.5581877701945, 4367.847125350598, 4424.34685604436, 4457.086297309044, 4630.32860235264, 4642.698224615389, 13745.656358591115, 14040.157590544395, 14043.929780351236, 14058.156510609191, 14059.578212653636, 12053.337066461429, 12980.610581682564, 13077.934610327078, 13718.588442346745, 13949.511767088103, 10118.949405253074, 10423.635172768916, 10444.947775261075, 10446.216533759998, 10469.790604187874, 5926.436988486087, 6577.868442631217, 6734.629595372302, 6793.5244532882225, 6873.621950792754, 12165.33090680021, 12203.633890983285, 12219.26684398939, 12293.139480236656, 12484.375781211085, 12464.002879769778, 12473.750524989631, 12655.0, 12838.0, 12865.356732163167, 7562.621868906643, 9213.12475314844, 9251.814963700823, 9420.199283060743, 9485.098915603006, 10152.137068349273, 10236.33463824849, 10347.896521034694, 10372.377657340583, 10401.375917444977, 9108.863367049633, 9138.360314777901, 9219.585118669542, 9222.44665320083, 9226.907730922605, 8882.200601945857, 8987.101289870961, 9060.54697265121, 9122.95086065111, 9143.451392916446, 6462.127612772404, 6753.581747832814, 7304.707811687473, 7353.558786472829, 7882.605869706606, 5442.183672449164, 5471.480209380103, 5501.477359650827, 5611.663300202001, 5746.511546518425, 5627.380988091389, 5651.124075768098, 5816.796412125555, 5918.23063001807, 5935.821925342247], "value": 5104.612458738825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.44083230160936, 360.86647940262105, 371.51517269962704, 372.9533808273966, 386.83559487217934, 4491.8321236478505, 4518.593326600605, 4909.459959404468, 5110.693358398494, 5181.637285390024, 4369.912601747963, 4609.492955774862, 4833.516648335165, 5063.4177069637, 5115.846524604259, 3838.794606503573, 4043.9595604044025, 4200.51694055183, 4257.084726783741, 4294.742315461074, 4044.5753195914444, 4066.9389959150635, 4302.827886884521, 4310.97844510777, 4356.867214524231, 3572.8392222349926, 3601.2977469393477, 4166.583341665824, 4366.956330436703, 4386.473623165225, 3743.513343265358, 3798.6961043116485, 3966.861159859391, 4040.5959404059654, 4368.453943257093, 3539.929201415983, 3630.7458477906557, 3864.7294689371756, 3941.2905676978135, 3944.861929832442, 3959.7925680199132, 4255.361695745632, 4283.400323954649, 4434.578715022068, 4564.406627138451, 4467.530909254547, 4809.350737650442, 4912.435069966964, 4927.802887884481, 4935.679180853269, 4861.416630004387, 5029.245613158019, 5378.892422151535, 5563.276774019392, 5582.720863956826, 3971.6028397160344, 4235.894102647459, 4357.477102747659, 4419.734815911055, 4419.867403977886, 5532.28080349556, 5564.520560948476, 5644.475991482318, 5781.421857814227, 5882.6764527950945, 3743.0907678954723, 4406.933895991563, 4507.774611269423, 4536.776979280195, 4545.068345953023, 4266.863855066524, 4606.723596584216, 4614.630829533629, 4619.976900115478, 4640.883977900579, 4506.355180359145, 4557.794899229542, 4647.58171764536, 4896.632752543574, 4940.728259945666, 4955.0, 5025.623078269145, 5098.0, 5555.444455554412, 5576.330840299109, 1408.8520705325998, 1409.6616811965055, 1458.5478501664518, 1464.1068947941747, 1499.2503748125937, 1015.5836107196014, 1070.464767616192, 1148.2019996102629, 1155.5435602936793, 1184.5202692909386, 4611.354410382549, 5089.312942752755, 5096.700341412916, 5133.409657889316, 5153.891913238672, 5115.565176959925, 5277.445868183785, 5312.634239418216, 5328.8276579152525, 5389.0299746046085, 4637.0, 4687.812487500461, 4947.282644016597, 5071.290019397287, 5143.8456846294675, 2778.624885640453, 2967.442092901244, 2971.5097008993707, 2981.3142977115385, 2990.489802649648, 5685.891251206058, 5777.277840269966, 5986.491148252448, 6003.979323514925, 6036.667983260875, 4904.60763138948, 5335.626506144533, 5353.86615334612, 5467.4532546745, 5883.499707574541, 5083.051829938627, 5414.35027796667, 5969.403059693996, 5989.143365556692, 5995.430434108753, 4982.800687972441, 5015.749212539431, 5537.363203231519, 5785.190073389813, 5793.478586927196, 5172.5603323716405, 5410.212851004391, 5441.782328706808, 5504.669719816664, 5654.547636189012, 4922.852314430573, 5164.845054648366, 5576.6299322786845, 5876.3536011039605, 5965.582409231486, 3650.9594765491706, 4083.8570650027104, 4365.847195348148, 4436.667249956331, 4494.932576011297, 4752.120857641347, 5736.4550367715, 5751.252337196138, 5762.654240745401, 5800.477956983892, 4415.470143582791, 4927.704337739747, 5221.791128354976, 5570.10616390413, 5609.607327487037, 5236.89526209466, 5542.861428464321, 5560.748831512878, 5595.216669666169, 5631.607346269916, 4746.525347465225, 4972.403311602631, 5393.946060539344, 5438.6192966493545, 5477.75350109254, 4647.4439058517, 4660.300954856663, 5499.312585926759, 5538.6399884007415, 5603.187537807076, 4918.631102667386, 5156.9428267205885, 5431.79036246896, 5447.455254474521, 5494.8735509221315], "value": 4164.952718074678, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.686857782576, 734.0457405373018, 776.6543887969852, 817.7546735979207, 825.7605294464605, 14181.503647372345, 14872.925635371808, 14880.776788348183, 14917.328720207603, 14925.029873058258, 11524.423778811048, 13680.931595342034, 13684.794728079087, 13740.381682824273, 13750.037497375188, 871.2072014466836, 893.5889490834224, 895.6596493332524, 896.3814967672317, 922.137801155918, 934.4813628436215, 944.4616568555925, 948.615810596706, 954.0840792838883, 954.7994921066585, 999.6201443451479, 1000.6297669862162, 1001.4341896828305, 1002.3634991780199, 1003.909648131668, 994.5176589354157, 995.2336700740461, 996.3772642098688, 998.475800204891, 999.635133176389, 740.551966060531, 741.6921977379382, 742.6138408027796, 743.379278302618, 743.4498471131378, 14852.33164507589, 14912.70174596502, 15167.848321516754, 15300.846991530054, 15402.152881591508, 13028.869711302861, 13250.271235082068, 13386.129901556367, 13444.126131801402, 13512.662183445493, 10215.540300686487, 11220.531483073792, 11367.488463019185, 11543.74850585706, 11860.703482412922, 3522.295540891832, 3553.1650062235353, 3656.8902932912056, 3714.9783809452347, 3784.8864534064023, 109491.0, 113285.0, 113331.0, 113582.0, 116558.41720791426, 9764.0, 9990.800183996425, 10125.898741012496, 10285.177185825116, 10407.53166107527, 21241.0, 21360.35918922435, 21669.67495487569, 21687.34937951864, 21730.78269217319, 6671.666416679147, 7359.153697324769, 7417.666205020679, 7465.514741541782, 7489.625518724042, 4176.83292668296, 4191.685623578243, 4249.80875860587, 4414.0, 4448.977755111204, 3314.668533146666, 3404.131946353664, 3412.19813343864, 3414.812185329781, 3431.4338134208074, 597.9312379076462, 619.4765423217374, 632.8512799492115, 636.4939872801134, 642.6369101457661, 550.8044644151348, 674.8717743628695, 687.5977553131374, 689.9379055884995, 700.6846918886522, 9993.512002794772, 9999.450030248261, 10184.796304073878, 10222.028907253947, 10245.538950747085, 680.6766785776716, 688.8243497908002, 709.3474003916409, 717.7846646006177, 720.3948831211133, 4120.649744771668, 4145.709800313949, 4206.831726730958, 4284.485861696617, 4362.912741745147, 111401.0, 114363.0, 114421.0, 115213.0, 115262.0, 97173.5141324303, 98606.50696746471, 99078.5046074765, 99195.00804992003, 101163.98836011693, 62790.0, 76771.08072298125, 77870.61064694753, 77994.0, 80681.596592019, 7957.56233407145, 8072.717454889051, 8075.192480752113, 8137.715179968673, 8147.0, 45761.08477830491, 46018.76990615026, 52171.47828521818, 53310.73344633252, 54676.17985730138, 63802.652456364565, 70252.64873675599, 70535.29464705287, 71324.28675713176, 71961.0, 12194.817077743663, 12207.877921220674, 12689.302088385228, 12768.634656866469, 12785.48858045705, 14134.646633834236, 14417.207053611732, 14583.0, 14764.48324308644, 15346.846531534988, 12399.690007749878, 12509.687257818627, 13520.053596248561, 13726.588202353945, 13857.653558661113, 13128.671783205114, 13559.254241016839, 13726.176429414267, 13901.16593004423, 14147.415614430334, 10883.78232435331, 12902.935485322514, 13264.535741249396, 13904.860951390356, 14024.579262622137, 10867.510962006887, 10874.619388321371, 11309.604163854226, 11688.415579220835, 11731.530738770354, 9869.802603947737, 10069.345492542961, 11201.775964480501, 11252.493637786156, 11310.94344528272], "value": 7505.487538229646, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1436.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 115.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 113.0, 168.0, 135.0, 128.0, 108.0, 106.0, 130.0, 109.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 184.0, 188.0, 183.0, 186.0, 183.0, 183.0, 183.0, 186.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 65.0, 81.0, 113.0, 60.0, 62.0, 59.0, 60.0, 75.0, 59.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 68.0, 86.0, 70.0, 69.0, 68.0, 83.0, 69.0, 67.0, 85.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 87.0, 87.0, 87.0, 88.0, 86.0, 87.0, 87.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 106.0, 153.0, 94.0, 93.0, 93.0, 98.0, 94.0, 94.0], "value": 101.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 85.0, 83.0, 84.0, 86.0, 84.0, 85.0, 89.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 61.0, 61.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 69.0, 65.0, 60.0, 59.0, 59.0, 58.0, 58.0, 58.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 83.0, 86.0, 84.0, 86.0, 81.0, 86.0, 90.0, 90.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 143.0, 142.0, 148.0, 139.0, 131.0, 138.0, 204.0, 137.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 166.0, 167.0, 167.0, 164.0, 206.0, 174.0, 165.0, 166.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 64.0, 66.0, 64.0, 64.0, 64.0, 66.0, 64.0, 64.0], "value": 64.9, "unit": "score"}]}]} 10:40:03 INFO - Return code: 0 10:40:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:40:03 ERROR - # TBPL SUCCESS # 10:40:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:40:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:40:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:40:03 INFO - 2017-03-16 10:40:03.484 screenresolution[1653:10123] starting screenresolution argv=screenresolution get 10:40:03 INFO - 2017-03-16 10:40:03.487 screenresolution[1653:10123] Display 0: 1600x1200x32@60 10:40:03 INFO - 2017-03-16 10:40:03.493 screenresolution[1654:10127] starting screenresolution argv=screenresolution list 10:40:03 INFO - Available Modes on Display 0 10:40:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:40:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:40:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:40:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:40:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:40:03 INFO - Intel Iris: 10:40:03 INFO - Chipset Model: Intel Iris 10:40:03 INFO - Type: GPU 10:40:03 INFO - Bus: Built-In 10:40:03 INFO - VRAM (Dynamic, Max): 1536 MB 10:40:03 INFO - Vendor: Intel (0x8086) 10:40:03 INFO - Device ID: 0x0a2e 10:40:03 INFO - Revision ID: 0x0009 10:40:03 INFO - Displays: 10:40:03 INFO - Display: 10:40:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:40:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:40:03 INFO - Display Serial Number: 1600x1200 60 10:40:03 INFO - Main Display: Yes 10:40:03 INFO - Mirror: Off 10:40:03 INFO - Online: Yes 10:40:03 INFO - Rotation: Supported 10:40:03 INFO - Return code: 0 10:40:03 INFO - Running post-action listener: _resource_record_post_action 10:40:03 INFO - [mozharness: 2017-03-16 17:40:03.731516Z] Finished run-tests step (success) 10:40:03 INFO - Running post-run listener: _resource_record_post_run 10:40:03 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37823488; Write bytes: 510289920; Read time: 236; Write time: 1560 10:40:03 INFO - TinderboxPrint: CPU usage
54.0% 10:40:03 INFO - TinderboxPrint: I/O read bytes / time
37,823,488 / 236 10:40:03 INFO - TinderboxPrint: I/O write bytes / time
510,289,920 / 1,560 10:40:03 INFO - TinderboxPrint: CPU idle
2,213.0 (46.0%) 10:40:03 INFO - TinderboxPrint: CPU system
957.9 (19.9%) 10:40:03 INFO - TinderboxPrint: CPU user
1,638.7 (34.1%) 10:40:03 INFO - TinderboxPrint: Swap in / out
260,493,312 / 0 10:40:03 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204179968; Write bytes: 202352640; Read time: 15777; Write time: 413 10:40:03 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 35873792; Write bytes: 297181184; Read time: 218; Write time: 1112 10:40:04 INFO - Running post-run listener: _upload_blobber_files 10:40:04 INFO - Blob upload gear active. 10:40:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:40:04 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 10:40:04 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'] 10:40:04 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 10:40:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:40:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:40:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:40:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:06 INFO - (blobuploader) - INFO - Done attempting. 10:40:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:40:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:07 INFO - (blobuploader) - INFO - Done attempting. 10:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:40:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:09 INFO - (blobuploader) - INFO - Done attempting. 10:40:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:40:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:11 INFO - (blobuploader) - INFO - Done attempting. 10:40:11 INFO - (blobuploader) - INFO - Iteration through files over. 10:40:11 INFO - Return code: 0 10:40:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:40:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:40:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fb434d30ae84747346036085789bcb18a986b1bd52e6ffee7dc3bb57e62de5eee99289d7ec706101f42af5e31f91e97884ce01fa1dcc003fc8cc63a44605480", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f231146717f35108e9057b4db6833fef3015f670002d224e99cf10ab2b8a99e3bae8fd125616ba32007ff6c99516ff50a6106b68062acba00b4bd93ef3bbb307", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/543624770fd2e4e0ee891e5fcb7b48e90810ceb77f30626d9b07ab2a8c0ccd14d6b309650ed90f48c251306c89b4ff00f2d3aa32bca8970a436873b85433e9a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96a31ba8f3735ed165c7b84c517043a5952799574d757be309087fab8fa8cdaa53ad3b0c929261c57906dc11d406ff8de3211b7f856f480e267afa85c0140762"} 10:40:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:40:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:40:11 INFO - Contents: 10:40:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fb434d30ae84747346036085789bcb18a986b1bd52e6ffee7dc3bb57e62de5eee99289d7ec706101f42af5e31f91e97884ce01fa1dcc003fc8cc63a44605480", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f231146717f35108e9057b4db6833fef3015f670002d224e99cf10ab2b8a99e3bae8fd125616ba32007ff6c99516ff50a6106b68062acba00b4bd93ef3bbb307", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/543624770fd2e4e0ee891e5fcb7b48e90810ceb77f30626d9b07ab2a8c0ccd14d6b309650ed90f48c251306c89b4ff00f2d3aa32bca8970a436873b85433e9a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96a31ba8f3735ed165c7b84c517043a5952799574d757be309087fab8fa8cdaa53ad3b0c929261c57906dc11d406ff8de3211b7f856f480e267afa85c0140762"} 10:40:11 INFO - Running post-run listener: copy_logs_to_upload_dir 10:40:11 INFO - Copying logs to upload dir... 10:40:11 INFO - mkdir: /builds/slave/test/build/upload/logs 10:40:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.905978 ========= master_lag: 0.29 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-03-16 10:40:11.583929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 10:40:11.587001) ========= 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.BXFEc4Pt42/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.GiyIbVqt60/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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/6fb434d30ae84747346036085789bcb18a986b1bd52e6ffee7dc3bb57e62de5eee99289d7ec706101f42af5e31f91e97884ce01fa1dcc003fc8cc63a44605480", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f231146717f35108e9057b4db6833fef3015f670002d224e99cf10ab2b8a99e3bae8fd125616ba32007ff6c99516ff50a6106b68062acba00b4bd93ef3bbb307", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/543624770fd2e4e0ee891e5fcb7b48e90810ceb77f30626d9b07ab2a8c0ccd14d6b309650ed90f48c251306c89b4ff00f2d3aa32bca8970a436873b85433e9a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96a31ba8f3735ed165c7b84c517043a5952799574d757be309087fab8fa8cdaa53ad3b0c929261c57906dc11d406ff8de3211b7f856f480e267afa85c0140762"} build_url:https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011046 build_url: 'https://queue.taskcluster.net/v1/task/KQYTz3_SQzuT6bcM6dr_7g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fb434d30ae84747346036085789bcb18a986b1bd52e6ffee7dc3bb57e62de5eee99289d7ec706101f42af5e31f91e97884ce01fa1dcc003fc8cc63a44605480", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f231146717f35108e9057b4db6833fef3015f670002d224e99cf10ab2b8a99e3bae8fd125616ba32007ff6c99516ff50a6106b68062acba00b4bd93ef3bbb307", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/543624770fd2e4e0ee891e5fcb7b48e90810ceb77f30626d9b07ab2a8c0ccd14d6b309650ed90f48c251306c89b4ff00f2d3aa32bca8970a436873b85433e9a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96a31ba8f3735ed165c7b84c517043a5952799574d757be309087fab8fa8cdaa53ad3b0c929261c57906dc11d406ff8de3211b7f856f480e267afa85c0140762"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 10:40:11.623785) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 10:40:11.624359) ========= 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.BXFEc4Pt42/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.GiyIbVqt60/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.005255 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 10:40:11.672371) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 10:40:11.672695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 10:40:11.673002) ========= ========= Total master_lag: 0.42 =========