builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0092 starttime: 1487263650.12 results: success (0) buildid: 20170216072519 builduid: 477cd6b09f584b17afe2d8fcbb5ed1fc revision: 8dadad0f570d4e76beb0d9300a1ccb90926cf6d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:30.123735) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:30.124217) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:30.124500) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:30.148911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:30.149274) ========= 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.br1E5p936P/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.KrEnzAbDWr/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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-02-16 08:47:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.02M=0.001s 2017-02-16 08:47:30 (8.02 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128193 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:30.300691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:30.301032) ========= 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.br1E5p936P/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.KrEnzAbDWr/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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.021926 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:30.350114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-16 08:47:30.350478) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8dadad0f570d4e76beb0d9300a1ccb90926cf6d2 --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 8dadad0f570d4e76beb0d9300a1ccb90926cf6d2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.br1E5p936P/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.KrEnzAbDWr/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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-02-16 08:47:30,441 truncating revision to first 12 chars 2017-02-16 08:47:30,441 Setting DEBUG logging. 2017-02-16 08:47:30,441 attempt 1/10 2017-02-16 08:47:30,442 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8dadad0f570d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-16 08:47:31,668 unpacking tar archive at: mozilla-aurora-8dadad0f570d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.489985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-16 08:47:31.863999) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:31.864376) ========= script_repo_revision: 8dadad0f570d4e76beb0d9300a1ccb90926cf6d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:31.864782) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:31.865045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 08:47:31.884561) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-16 08:47:31.884876) ========= /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.br1E5p936P/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.KrEnzAbDWr/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 08:47:32 INFO - MultiFileLogger online at 20170216 08:47:32 in /builds/slave/test 08:47:32 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 08:47:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:32 INFO - {'append_to_log': False, 08:47:32 INFO - 'base_work_dir': '/builds/slave/test', 08:47:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:47:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:32 INFO - 'branch': 'Mozilla-Aurora', 08:47:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:32 INFO - 'config_files': ('talos/mac_config.py',), 08:47:32 INFO - 'default_actions': ('clobber', 08:47:32 INFO - 'read-buildbot-config', 08:47:32 INFO - 'download-and-extract', 08:47:32 INFO - 'populate-webroot', 08:47:32 INFO - 'create-virtualenv', 08:47:32 INFO - 'install', 08:47:32 INFO - 'run-tests'), 08:47:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:32 INFO - 'download_minidump_stackwalk': True, 08:47:32 INFO - 'download_symbols': 'ondemand', 08:47:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:32 INFO - 'installer_path': 'installer.exe', 08:47:32 INFO - 'log_level': 'info', 08:47:32 INFO - 'log_name': 'talos', 08:47:32 INFO - 'log_to_console': True, 08:47:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:47:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:47:32 INFO - 'opt_config_files': (), 08:47:32 INFO - 'pip_index': False, 08:47:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:47:32 INFO - 'cmd': ('bash', 08:47:32 INFO - '-c', 08:47:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:47:32 INFO - 'enabled': True, 08:47:32 INFO - 'halt_on_failure': False, 08:47:32 INFO - 'name': 'check_screen_resolution'},), 08:47:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:47:32 INFO - 'cmd': ('bash', 08:47:32 INFO - '-c', 08:47:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:47:32 INFO - 'enabled': True, 08:47:32 INFO - 'halt_on_failure': False, 08:47:32 INFO - 'name': 'check_screen_resolution'},), 08:47:32 INFO - 'run_cmd_checks_enabled': True, 08:47:32 INFO - 'sps_profile': False, 08:47:32 INFO - 'sps_profile_interval': 0, 08:47:32 INFO - 'suite': 'dromaeojs', 08:47:32 INFO - 'system_bits': '32', 08:47:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:32 INFO - 'title': 't-yosemite-r7-0092', 08:47:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:32 INFO - 'use_talos_json': True, 08:47:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:32 INFO - 'work_dir': 'build'} 08:47:32 INFO - [mozharness: 2017-02-16 16:47:32.095855Z] Running clobber step. 08:47:32 INFO - Running pre-action listener: _resource_record_pre_action 08:47:32 INFO - Running main action method: clobber 08:47:32 INFO - rmtree: /builds/slave/test/build 08:47:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:34 INFO - Running post-action listener: _resource_record_post_action 08:47:34 INFO - [mozharness: 2017-02-16 16:47:34.201465Z] Finished clobber step (success) 08:47:34 INFO - [mozharness: 2017-02-16 16:47:34.201597Z] Running read-buildbot-config step. 08:47:34 INFO - Running pre-action listener: _resource_record_pre_action 08:47:34 INFO - Running main action method: read_buildbot_config 08:47:34 INFO - Using buildbot properties: 08:47:34 INFO - { 08:47:34 INFO - "project": "", 08:47:34 INFO - "product": "firefox", 08:47:34 INFO - "script_repo_revision": "production", 08:47:34 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:47:34 INFO - "repository": "", 08:47:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:47:34 INFO - "buildid": "20170216072519", 08:47:34 INFO - "pgo_build": "False", 08:47:34 INFO - "basedir": "/builds/slave/test", 08:47:34 INFO - "buildnumber": 4, 08:47:34 INFO - "slavename": "t-yosemite-r7-0092", 08:47:34 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:47:34 INFO - "platform": "yosemite_r7", 08:47:34 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:47:34 INFO - "branch": "mozilla-aurora", 08:47:34 INFO - "repo_path": "releases/mozilla-aurora", 08:47:34 INFO - "revision": "8dadad0f570d4e76beb0d9300a1ccb90926cf6d2", 08:47:34 INFO - "stage_platform": "macosx64", 08:47:34 INFO - "builduid": "477cd6b09f584b17afe2d8fcbb5ed1fc", 08:47:34 INFO - "slavebuilddir": "test" 08:47:34 INFO - } 08:47:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:47:34 INFO - Running post-action listener: _resource_record_post_action 08:47:34 INFO - [mozharness: 2017-02-16 16:47:34.204911Z] Finished read-buildbot-config step (success) 08:47:34 INFO - [mozharness: 2017-02-16 16:47:34.205027Z] Running download-and-extract step. 08:47:34 INFO - Running pre-action listener: _resource_record_pre_action 08:47:34 INFO - Running main action method: download_and_extract 08:47:34 INFO - mkdir: /builds/slave/test/build/tests 08:47: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')]} 08:47:34 INFO - trying https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:47:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:47:35 INFO - Downloaded 1199 bytes. 08:47:35 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:47:35 INFO - Using the following test package requirements: 08:47:35 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:47:35 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:35 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:47:35 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:35 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:47:35 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:35 INFO - u'jsshell-mac.zip'], 08:47:35 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:35 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:47:35 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:47:35 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:35 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:47:35 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:35 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:47:35 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:35 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:47:35 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:47:35 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:47:35 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:47:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:47:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:47:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:47:36 INFO - Expected file size: 16358255 08:47:36 INFO - Obtained file size: 16358255 08:47:43 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:47:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:47:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:47:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:47:44 INFO - Expected file size: 16358255 08:47:44 INFO - Obtained file size: 16358255 08:47:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:47:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:47:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:47:52 INFO - Expected file size: 14403485 08:47:52 INFO - Obtained file size: 14403485 08:47:52 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')]} 08:47:52 INFO - trying https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:47:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:47:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:47:54 INFO - Downloaded 73943537 bytes. 08:47:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:47:54 INFO - mkdir: /builds/slave/test/properties 08:47:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:47:54 INFO - Writing to file /builds/slave/test/properties/build_url 08:47:54 INFO - Contents: 08:47:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:47:55 INFO - Running post-action listener: _resource_record_post_action 08:47:55 INFO - Running post-action listener: set_extra_try_arguments 08:47:55 INFO - [mozharness: 2017-02-16 16:47:55.270857Z] Finished download-and-extract step (success) 08:47:55 INFO - [mozharness: 2017-02-16 16:47:55.270963Z] Running populate-webroot step. 08:47:55 INFO - Running pre-action listener: _resource_record_pre_action 08:47:55 INFO - Running main action method: populate_webroot 08:47:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:47:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:47:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:47:55 INFO - '--tppagecycles', 08:47:55 INFO - '7'], 08:47:55 INFO - 'tests': ['tsvgm']}}, 08:47:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:47:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:47:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:47:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:47:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:47:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:47:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:47:55 INFO - 'talos_options': ['--disable-e10s'], 08:47:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:47:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:47:55 INFO - 'talos_options': ['--disable-e10s'], 08:47:55 INFO - 'tests': ['damp', 'tps']}, 08:47:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:47:55 INFO - 'tests': ['damp', 'tps']}, 08:47:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:47:55 INFO - 'tests': ['dromaeo_dom']}, 08:47:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:47:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:47:55 INFO - 'tests': ['basic_compositor_video']}, 08:47:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:47:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:47:55 INFO - 'tests': ['a11yr', 08:47:55 INFO - 'ts_paint', 08:47:55 INFO - 'tpaint', 08:47:55 INFO - 'sessionrestore', 08:47:55 INFO - 'sessionrestore_no_auto_restore', 08:47:55 INFO - 'tabpaint']}, 08:47:55 INFO - 'other-e10s': {'tests': ['a11yr', 08:47:55 INFO - 'ts_paint', 08:47:55 INFO - 'tpaint', 08:47:55 INFO - 'sessionrestore', 08:47:55 INFO - 'sessionrestore_no_auto_restore', 08:47:55 INFO - 'tabpaint']}, 08:47:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:47:55 INFO - 'ts_paint', 08:47:55 INFO - 'tpaint', 08:47:55 INFO - 'sessionrestore', 08:47:55 INFO - 'sessionrestore_no_auto_restore', 08:47:55 INFO - 'tabpaint']}, 08:47:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:47:55 INFO - 'ts_paint', 08:47:55 INFO - 'tpaint', 08:47:55 INFO - 'sessionrestore', 08:47:55 INFO - 'sessionrestore_no_auto_restore', 08:47:55 INFO - 'tabpaint']}, 08:47:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:47:55 INFO - 'tests': ['a11yr', 08:47:55 INFO - 'ts_paint', 08:47:55 INFO - 'tpaint', 08:47:55 INFO - 'sessionrestore', 08:47:55 INFO - 'sessionrestore_no_auto_restore', 08:47:55 INFO - 'tabpaint']}, 08:47:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:47:55 INFO - 'tests': ['a11yr', 08:47:55 INFO - 'ts_paint', 08:47:55 INFO - 'tpaint', 08:47:55 INFO - 'sessionrestore', 08:47:55 INFO - 'sessionrestore_no_auto_restore', 08:47:55 INFO - 'tabpaint']}, 08:47:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:47:55 INFO - 'tests': ['tsvgx', 08:47:55 INFO - 'tsvgr_opacity', 08:47:55 INFO - 'tart', 08:47:55 INFO - 'tscrollx', 08:47:55 INFO - 'cart', 08:47:55 INFO - 'tsvg_static']}, 08:47:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:47:55 INFO - 'tsvgr_opacity', 08:47:55 INFO - 'tart', 08:47:55 INFO - 'tscrollx', 08:47:55 INFO - 'cart', 08:47:55 INFO - 'tsvg_static']}, 08:47:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:47:55 INFO - 'talos_options': ['--disable-e10s'], 08:47:55 INFO - 'tests': ['tp5o']}, 08:47:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:47:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:47:55 INFO - 'talos_options': ['--disable-e10s', 08:47:55 INFO - '--xperf_path', 08:47:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:55 INFO - 'tests': ['tp5n']}, 08:47:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:47:55 INFO - 'talos_options': ['--xperf_path', 08:47:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:55 INFO - 'tests': ['tp5n']}}, 08:47:55 INFO - 'talos.zip': {'path': '', 08:47:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:47:55 INFO - Running post-action listener: _resource_record_post_action 08:47:55 INFO - [mozharness: 2017-02-16 16:47:55.289715Z] Finished populate-webroot step (success) 08:47:55 INFO - [mozharness: 2017-02-16 16:47:55.289850Z] Running create-virtualenv step. 08:47:55 INFO - Running pre-action listener: _resource_record_pre_action 08:47:55 INFO - Running main action method: create_virtualenv 08:47:55 INFO - Creating virtualenv /builds/slave/test/build/venv 08:47:55 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 08:47:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:47:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:47:55 INFO - Using real prefix '/tools/python27' 08:47:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:47:56 INFO - Installing distribute.............................................................................................................................................................................................done. 08:47:58 INFO - Installing pip.................done. 08:47:58 INFO - Return code: 0 08:47:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:47:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:47:59 INFO - Reading from file tmpfile_stdout 08:47:59 INFO - Output received: 08:47:59 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) 08:47:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9871cd49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a00d30>, '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 0x102927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f5be8>, '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.br1E5p936P/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.KrEnzAbDWr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 08:47:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:47:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br1E5p936P/Render', 08:47:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:59 INFO - 'HOME': '/Users/cltbld', 08:47:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:59 INFO - 'LOGNAME': 'cltbld', 08:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:59 INFO - 'MOZ_NO_REMOTE': '1', 08:47:59 INFO - 'NO_EM_RESTART': '1', 08:47:59 INFO - 'PAGER': '/bin/cat', 08:47:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:59 INFO - 'PWD': '/builds/slave/test', 08:47:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:59 INFO - 'SHELL': '/bin/bash', 08:47:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KrEnzAbDWr/Listeners', 08:47:59 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 08:47:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:59 INFO - 'USER': 'cltbld', 08:47:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:59 INFO - 'XPC_FLAGS': '0x0', 08:47:59 INFO - 'XPC_SERVICE_NAME': '0', 08:47:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:59 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 08:47:59 INFO - Cleaning up... 08:47:59 INFO - Return code: 0 08:47:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102c22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9871cd49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a00d30>, '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 0x102927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f5be8>, '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.br1E5p936P/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.KrEnzAbDWr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 08:47:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:47:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br1E5p936P/Render', 08:47:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:59 INFO - 'HOME': '/Users/cltbld', 08:47:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:59 INFO - 'LOGNAME': 'cltbld', 08:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:59 INFO - 'MOZ_NO_REMOTE': '1', 08:47:59 INFO - 'NO_EM_RESTART': '1', 08:47:59 INFO - 'PAGER': '/bin/cat', 08:47:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:59 INFO - 'PWD': '/builds/slave/test', 08:47:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:59 INFO - 'SHELL': '/bin/bash', 08:47:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KrEnzAbDWr/Listeners', 08:47:59 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 08:47:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:59 INFO - 'USER': 'cltbld', 08:47:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:59 INFO - 'XPC_FLAGS': '0x0', 08:47:59 INFO - 'XPC_SERVICE_NAME': '0', 08:47:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:59 INFO - Downloading/unpacking psutil>=3.1.1 08:47:59 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 08:47:59 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 08:47:59 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 08:47:59 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 08:47:59 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 08:47:59 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 08:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:03 INFO - Installing collected packages: psutil 08:48:03 INFO - Running setup.py install for psutil 08:48:03 INFO - building 'psutil._psutil_osx' extension 08:48:03 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 08:48:03 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 08:48:03 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 08:48:03 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 08:48:03 INFO - building 'psutil._psutil_posix' extension 08:48:03 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 08:48:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:48:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:48:04 INFO - ^ 08:48:04 INFO - 1 warning generated. 08:48:04 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 08:48:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:04 INFO - Successfully installed psutil 08:48:04 INFO - Cleaning up... 08:48:04 INFO - Return code: 0 08:48:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:48:04 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')]} 08:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:04 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')]} 08:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:04 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 0x102c22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9871cd49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a00d30>, '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 0x102927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f5be8>, '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.br1E5p936P/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.KrEnzAbDWr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 08:48:04 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 08:48:04 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 08:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br1E5p936P/Render', 08:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:04 INFO - 'HOME': '/Users/cltbld', 08:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:04 INFO - 'LOGNAME': 'cltbld', 08:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:04 INFO - 'MOZ_NO_REMOTE': '1', 08:48:04 INFO - 'NO_EM_RESTART': '1', 08:48:04 INFO - 'PAGER': '/bin/cat', 08:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:04 INFO - 'PWD': '/builds/slave/test', 08:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:04 INFO - 'SHELL': '/bin/bash', 08:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KrEnzAbDWr/Listeners', 08:48:04 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 08:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:04 INFO - 'USER': 'cltbld', 08:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:04 INFO - 'XPC_FLAGS': '0x0', 08:48:04 INFO - 'XPC_SERVICE_NAME': '0', 08:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:48:04 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 08:48:04 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 08:48:04 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 08:48:04 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 08:48:04 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 08:48:04 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 08:48:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:48:07 INFO - Installing collected packages: mozsystemmonitor 08:48:07 INFO - Running setup.py install for mozsystemmonitor 08:48:07 INFO - Successfully installed mozsystemmonitor 08:48:07 INFO - Cleaning up... 08:48:07 INFO - Return code: 0 08:48:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102c22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9871cd49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a00d30>, '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 0x102927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f5be8>, '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.br1E5p936P/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.KrEnzAbDWr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 08:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:48:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br1E5p936P/Render', 08:48:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:07 INFO - 'HOME': '/Users/cltbld', 08:48:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:07 INFO - 'LOGNAME': 'cltbld', 08:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:07 INFO - 'MOZ_NO_REMOTE': '1', 08:48:07 INFO - 'NO_EM_RESTART': '1', 08:48:07 INFO - 'PAGER': '/bin/cat', 08:48:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:07 INFO - 'PWD': '/builds/slave/test', 08:48:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:07 INFO - 'SHELL': '/bin/bash', 08:48:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KrEnzAbDWr/Listeners', 08:48:07 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 08:48:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:07 INFO - 'USER': 'cltbld', 08:48:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:07 INFO - 'XPC_FLAGS': '0x0', 08:48:07 INFO - 'XPC_SERVICE_NAME': '0', 08:48:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:07 INFO - Downloading/unpacking jsonschema==2.5.1 08:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:48:10 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 08:48:10 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 08:48:10 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 08:48:10 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 08:48:10 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 08:48:10 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 08:48:10 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:10 INFO - warning: no files found matching '*.txt' 08:48:10 INFO - no previously-included directories found matching 'build' 08:48:10 INFO - no previously-included directories found matching 'dist' 08:48:10 INFO - no previously-included directories found matching '.git*' 08:48:10 INFO - Installing collected packages: jsonschema, functools32 08:48:10 INFO - Running setup.py install for functools32 08:48:11 INFO - warning: no files found matching '*.txt' 08:48:11 INFO - no previously-included directories found matching 'build' 08:48:11 INFO - no previously-included directories found matching 'dist' 08:48:11 INFO - no previously-included directories found matching '.git*' 08:48:11 INFO - Successfully installed jsonschema functools32 08:48:11 INFO - Cleaning up... 08:48:11 INFO - Return code: 0 08:48:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102c22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9871cd49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a00d30>, '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 0x102927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f5be8>, '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.br1E5p936P/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.KrEnzAbDWr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 08:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:48:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br1E5p936P/Render', 08:48:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:11 INFO - 'HOME': '/Users/cltbld', 08:48:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:11 INFO - 'LOGNAME': 'cltbld', 08:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:11 INFO - 'MOZ_NO_REMOTE': '1', 08:48:11 INFO - 'NO_EM_RESTART': '1', 08:48:11 INFO - 'PAGER': '/bin/cat', 08:48:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:11 INFO - 'PWD': '/builds/slave/test', 08:48:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:11 INFO - 'SHELL': '/bin/bash', 08:48:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KrEnzAbDWr/Listeners', 08:48:11 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 08:48:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:11 INFO - 'USER': 'cltbld', 08:48:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:11 INFO - 'XPC_FLAGS': '0x0', 08:48:11 INFO - 'XPC_SERVICE_NAME': '0', 08:48:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:48:11 INFO - Cleaning up... 08:48:11 INFO - Return code: 0 08:48:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102c22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9871cd49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a00d30>, '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 0x102927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f5be8>, '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.br1E5p936P/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.KrEnzAbDWr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 08:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:48:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br1E5p936P/Render', 08:48:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:11 INFO - 'HOME': '/Users/cltbld', 08:48:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:11 INFO - 'LOGNAME': 'cltbld', 08:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:11 INFO - 'MOZ_NO_REMOTE': '1', 08:48:11 INFO - 'NO_EM_RESTART': '1', 08:48:11 INFO - 'PAGER': '/bin/cat', 08:48:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:11 INFO - 'PWD': '/builds/slave/test', 08:48:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:11 INFO - 'SHELL': '/bin/bash', 08:48:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KrEnzAbDWr/Listeners', 08:48:11 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 08:48:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:11 INFO - 'USER': 'cltbld', 08:48:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:11 INFO - 'XPC_FLAGS': '0x0', 08:48:11 INFO - 'XPC_SERVICE_NAME': '0', 08:48:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:14 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:14 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 08:48:14 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 08:48:14 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 08:48:14 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 08:48:14 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 08:48:14 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 08:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48:14 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 08:48:14 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 08:48:14 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 08:48:14 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 08:48:14 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 08:48:14 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 08:48:15 INFO - Downloading docopt-0.6.1.tar.gz 08:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:15 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:15 INFO - Running setup.py install for blobuploader 08:48:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:15 INFO - Running setup.py install for requests 08:48:16 INFO - Running setup.py install for docopt 08:48:16 INFO - Successfully installed blobuploader requests docopt 08:48:16 INFO - Cleaning up... 08:48:16 INFO - Return code: 0 08:48:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:16 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 0x102c22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9871cd49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a00d30>, '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 0x102927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f5be8>, '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.br1E5p936P/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.KrEnzAbDWr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 08:48:16 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 08:48:16 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 08:48:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br1E5p936P/Render', 08:48:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:16 INFO - 'HOME': '/Users/cltbld', 08:48:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:16 INFO - 'LOGNAME': 'cltbld', 08:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:16 INFO - 'MOZ_NO_REMOTE': '1', 08:48:16 INFO - 'NO_EM_RESTART': '1', 08:48:16 INFO - 'PAGER': '/bin/cat', 08:48:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:16 INFO - 'PWD': '/builds/slave/test', 08:48:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:16 INFO - 'SHELL': '/bin/bash', 08:48:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KrEnzAbDWr/Listeners', 08:48:16 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 08:48:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:16 INFO - 'USER': 'cltbld', 08:48:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:16 INFO - 'XPC_FLAGS': '0x0', 08:48:16 INFO - 'XPC_SERVICE_NAME': '0', 08:48:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:16 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-cK9bRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:16 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-DCGzJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:16 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-87IM9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:17 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-9aMqqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:17 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-EQDbcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:17 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-uKSBFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:17 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-42rGFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:17 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-0bXxVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:17 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-Tdh6pS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:17 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-VgZ4S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:17 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-dUueAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:17 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-pbLbeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:17 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-TSvBFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:18 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-cCxu78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:18 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-9W7Xlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:18 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-LGxch3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:18 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-5Tt7C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:18 INFO - Running setup.py install for manifestparser 08:48:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:18 INFO - Running setup.py install for mozcrash 08:48:18 INFO - Running setup.py install for mozdebug 08:48:18 INFO - Running setup.py install for mozdevice 08:48:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozfile 08:48:19 INFO - Running setup.py install for mozhttpd 08:48:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozinfo 08:48:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozInstall 08:48:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozleak 08:48:19 INFO - Running setup.py install for mozlog 08:48:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Running setup.py install for moznetwork 08:48:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Running setup.py install for mozprocess 08:48:20 INFO - Running setup.py install for mozprofile 08:48:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Running setup.py install for mozrunner 08:48:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Running setup.py install for mozscreenshot 08:48:20 INFO - Running setup.py install for moztest 08:48:20 INFO - Running setup.py install for mozversion 08:48:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:21 INFO - Cleaning up... 08:48:21 INFO - Return code: 0 08:48:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48: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')]} 08:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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')]} 08:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:21 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 0x102c22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9871cd49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a00d30>, '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 0x102927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f5be8>, '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.br1E5p936P/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.KrEnzAbDWr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 08:48:21 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 08:48:21 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 08:48:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br1E5p936P/Render', 08:48:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:21 INFO - 'HOME': '/Users/cltbld', 08:48:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:21 INFO - 'LOGNAME': 'cltbld', 08:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:21 INFO - 'MOZ_NO_REMOTE': '1', 08:48:21 INFO - 'NO_EM_RESTART': '1', 08:48:21 INFO - 'PAGER': '/bin/cat', 08:48:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:21 INFO - 'PWD': '/builds/slave/test', 08:48:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:21 INFO - 'SHELL': '/bin/bash', 08:48:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KrEnzAbDWr/Listeners', 08:48:21 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 08:48:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:21 INFO - 'USER': 'cltbld', 08:48:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:21 INFO - 'XPC_FLAGS': '0x0', 08:48:21 INFO - 'XPC_SERVICE_NAME': '0', 08:48:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:21 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-Sq8S3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:21 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-77OTXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:21 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-mQFagj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:21 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-qPJ93m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:21 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-JlwT3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:21 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-1z1fWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:22 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-53cQ99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:22 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-MndfQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:22 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-9LPAhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:22 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-ARDEhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:22 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-7Gyg7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:22 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-II9leN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:22 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-oiVfBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:22 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-BZ0H_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:22 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-Uo8vab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:23 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)) 08:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:23 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-O4RGS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:23 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)) 08:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:23 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-e8jHMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:23 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)) 08:48:23 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)) 08:48:23 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)) 08:48:23 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)) 08:48:23 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)) 08:48:23 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)) 08:48:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:23 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 08:48:23 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 08:48:23 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 08:48:23 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 08:48:23 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 08:48:23 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 08:48:25 INFO - Downloading blessings-1.6.tar.gz 08:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:25 INFO - Installing collected packages: blessings 08:48:25 INFO - Running setup.py install for blessings 08:48:26 INFO - Successfully installed blessings 08:48:26 INFO - Cleaning up... 08:48:26 INFO - Return code: 0 08:48:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:26 INFO - Reading from file tmpfile_stdout 08:48:26 INFO - Current package versions: 08:48:26 INFO - blessings == 1.6 08:48:26 INFO - blobuploader == 1.2.4 08:48:26 INFO - docopt == 0.6.1 08:48:26 INFO - functools32 == 3.2.3-2 08:48:26 INFO - jsonschema == 2.5.1 08:48:26 INFO - manifestparser == 1.1 08:48:26 INFO - mozInstall == 1.12 08:48:26 INFO - mozcrash == 1.0 08:48:26 INFO - mozdebug == 0.1 08:48:26 INFO - mozdevice == 0.49 08:48:26 INFO - mozfile == 1.2 08:48:26 INFO - mozhttpd == 0.7 08:48:26 INFO - mozinfo == 0.9 08:48:26 INFO - mozleak == 0.1 08:48:26 INFO - mozlog == 3.4 08:48:26 INFO - moznetwork == 0.27 08:48:26 INFO - mozprocess == 0.24 08:48:26 INFO - mozprofile == 0.28 08:48:26 INFO - mozrunner == 6.13 08:48:26 INFO - mozscreenshot == 0.1 08:48:26 INFO - mozsystemmonitor == 0.3 08:48:26 INFO - moztest == 0.8 08:48:26 INFO - mozversion == 1.4 08:48:26 INFO - psutil == 3.1.1 08:48:26 INFO - requests == 1.2.3 08:48:26 INFO - wsgiref == 0.1.2 08:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:26 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')]} 08:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:26 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')]} 08:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:27 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 0x102c22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9871cd49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a00d30>, '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 0x102927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f5be8>, '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.br1E5p936P/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.KrEnzAbDWr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 08:48:27 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 08:48:27 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 08:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br1E5p936P/Render', 08:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:27 INFO - 'HOME': '/Users/cltbld', 08:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:27 INFO - 'LOGNAME': 'cltbld', 08:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:27 INFO - 'MOZ_NO_REMOTE': '1', 08:48:27 INFO - 'NO_EM_RESTART': '1', 08:48:27 INFO - 'PAGER': '/bin/cat', 08:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:27 INFO - 'PWD': '/builds/slave/test', 08:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:27 INFO - 'SHELL': '/bin/bash', 08:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KrEnzAbDWr/Listeners', 08:48:27 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 08:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:27 INFO - 'USER': 'cltbld', 08:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:27 INFO - 'XPC_FLAGS': '0x0', 08:48:27 INFO - 'XPC_SERVICE_NAME': '0', 08:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:27 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)) 08:48:27 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)) 08:48:27 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)) 08:48:27 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)) 08:48:27 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)) 08:48:27 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)) 08:48:27 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)) 08:48:27 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)) 08:48:27 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)) 08:48:27 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)) 08:48:27 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)) 08:48:27 INFO - Cleaning up... 08:48:27 INFO - Return code: 0 08:48:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:27 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')]} 08:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:27 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')]} 08:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:27 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 0x102c22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9871cd49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a00d30>, '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 0x102927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f5be8>, '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.br1E5p936P/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.KrEnzAbDWr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 08:48:27 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 08:48:27 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 08:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br1E5p936P/Render', 08:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:27 INFO - 'HOME': '/Users/cltbld', 08:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:27 INFO - 'LOGNAME': 'cltbld', 08:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:27 INFO - 'MOZ_NO_REMOTE': '1', 08:48:27 INFO - 'NO_EM_RESTART': '1', 08:48:27 INFO - 'PAGER': '/bin/cat', 08:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:27 INFO - 'PWD': '/builds/slave/test', 08:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:27 INFO - 'SHELL': '/bin/bash', 08:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KrEnzAbDWr/Listeners', 08:48:27 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 08:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:27 INFO - 'USER': 'cltbld', 08:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:27 INFO - 'XPC_FLAGS': '0x0', 08:48:27 INFO - 'XPC_SERVICE_NAME': '0', 08:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:28 INFO - Cleaning up... 08:48:28 INFO - Return code: 0 08:48:28 INFO - Running post-action listener: _resource_record_post_action 08:48:28 INFO - Running post-action listener: _start_resource_monitoring 08:48:28 INFO - Starting resource monitoring. 08:48:28 INFO - [mozharness: 2017-02-16 16:48:28.151297Z] Finished create-virtualenv step (success) 08:48:28 INFO - [mozharness: 2017-02-16 16:48:28.152295Z] Running install step. 08:48:28 INFO - Running pre-action listener: _resource_record_pre_action 08:48:28 INFO - Running main action method: install 08:48:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:28 INFO - Reading from file tmpfile_stdout 08:48:28 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:28 INFO - Reading from file tmpfile_stdout 08:48:28 INFO - Output received: 08:48:28 INFO - Usage: mozinstall [options] installer 08:48:28 INFO - Options: 08:48:28 INFO - -h, --help show this help message and exit 08:48:28 INFO - -d DEST, --destination=DEST 08:48:28 INFO - Directory to install application into. [default: 08:48:28 INFO - "/builds/slave/test"] 08:48:28 INFO - --app=APP Application being installed. [default: firefox] 08:48:28 INFO - mkdir: /builds/slave/test/build/application 08:48:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:48:48 INFO - Reading from file tmpfile_stdout 08:48:48 INFO - Output received: 08:48:48 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:48:48 INFO - Running post-action listener: _resource_record_post_action 08:48:48 INFO - [mozharness: 2017-02-16 16:48:48.509594Z] Finished install step (success) 08:48:48 INFO - [mozharness: 2017-02-16 16:48:48.509787Z] Running run-tests step. 08:48:48 INFO - Running pre-action listener: _resource_record_pre_action 08:48:48 INFO - Running main action method: run_tests 08:48:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:48:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:48:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:48:48 INFO - 2017-02-16 08:48:48.524 screenresolution[2171:70541] starting screenresolution argv=screenresolution get 08:48:48 INFO - 2017-02-16 08:48:48.527 screenresolution[2171:70541] Display 0: 1600x1200x32@60 08:48:48 INFO - 2017-02-16 08:48:48.533 screenresolution[2172:70544] starting screenresolution argv=screenresolution list 08:48:48 INFO - Available Modes on Display 0 08:48:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:48:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:48:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:48:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:48:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:48:48 INFO - Intel Iris: 08:48:48 INFO - Chipset Model: Intel Iris 08:48:48 INFO - Type: GPU 08:48:48 INFO - Bus: Built-In 08:48:48 INFO - VRAM (Dynamic, Max): 1536 MB 08:48:48 INFO - Vendor: Intel (0x8086) 08:48:48 INFO - Device ID: 0x0a2e 08:48:48 INFO - Revision ID: 0x0009 08:48:48 INFO - Displays: 08:48:48 INFO - Display: 08:48:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:48:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:48:48 INFO - Display Serial Number: 1600x1200 60 08:48:48 INFO - Main Display: Yes 08:48:48 INFO - Mirror: Off 08:48:48 INFO - Online: Yes 08:48:48 INFO - Rotation: Supported 08:48:48 INFO - Return code: 0 08:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:48 INFO - Python 2.7.3 08:48:48 INFO - Return code: 0 08:48:48 INFO - grabbing minidump binary from tooltool 08:48: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')]} 08:48:48 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 0x102a00d30>, '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 0x102927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:48 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 08:48:48 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 08:48:48 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 08:48:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:48 INFO - Return code: 0 08:48:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:48:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:48:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:48 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/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 08:48:48 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/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0092 --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 08:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br1E5p936P/Render', 08:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:48 INFO - 'HOME': '/Users/cltbld', 08:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:48 INFO - 'LOGNAME': 'cltbld', 08:48:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:48 INFO - 'MOZ_NO_REMOTE': '1', 08:48:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:48 INFO - 'NO_EM_RESTART': '1', 08:48:48 INFO - 'PAGER': '/bin/cat', 08:48:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:48 INFO - 'PWD': '/builds/slave/test', 08:48:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:48 INFO - 'SHELL': '/bin/bash', 08:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KrEnzAbDWr/Listeners', 08:48:48 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 08:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:48 INFO - 'USER': 'cltbld', 08:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:48 INFO - 'XPC_FLAGS': '0x0', 08:48:48 INFO - 'XPC_SERVICE_NAME': '0', 08:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:48 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/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 08:48:49 INFO - mozversion application_buildid: 20170216072519 08:48:49 INFO - mozversion application_changeset: 8dadad0f570d4e76beb0d9300a1ccb90926cf6d2 08:48:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:48:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:49 INFO - mozversion application_name: Firefox 08:48:49 INFO - mozversion application_remotingname: firefox-dev 08:48:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:48:49 INFO - mozversion application_vendor: Mozilla 08:48:49 INFO - mozversion application_version: 53.0a2 08:48:49 INFO - mozversion platform_buildid: 20170216072519 08:48:49 INFO - mozversion platform_changeset: 8dadad0f570d4e76beb0d9300a1ccb90926cf6d2 08:48:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:48:49 INFO - mozversion platform_version: 53.0a2 08:48:49 INFO - using testdate: 1487263729 08:48:49 INFO - actual date: 1487263729 08:48:49 INFO - starting webserver on 'localhost:55412' 08:48:49 INFO - SUITE-START | Running 2 tests 08:48:49 INFO - TEST-START | dromaeo_css 08:48:49 INFO - operating with platform_type : mac_ 08:48:49 INFO - Initialising browser for dromaeo_css test... 08:48:49 INFO - TEST-INFO | started process 2182 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/tmpPYB0wQ/profile http://localhost:55412/getInfo.html) 08:48:51 INFO - PROCESS | 2182 | __metrics Screen width/height:1600/1200 08:48:51 INFO - PROCESS | 2182 | colorDepth:24 08:48:51 INFO - PROCESS | 2182 | Browser inner width/height: 1024/689 08:48:51 INFO - PROCESS | 2182 | __metrics 08:48:51 INFO - PROCESS | 2182 | 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" 08:48:51 INFO - PROCESS | 2182 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:52 INFO - TEST-INFO | 2182: exit 0 08:48:52 INFO - Browser initialized. 08:48:52 INFO - Running cycle 1/1 for dromaeo_css test... 08:48:52 INFO - TEST-INFO | started process 2184 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/tmpPYB0wQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:04 INFO - PROCESS | 2184 | RSS: Main: 213831680 08:49:04 INFO - PROCESS | 2184 | 08:52:08 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:55412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55412/tests/dromaeo/cssquery-ext.html) 08:52:10 INFO - PROCESS | 2184 | RSS: Main: 371941376 08:52:10 INFO - PROCESS | 2184 | 08:53:54 INFO - PROCESS | 2184 | ************************* 08:53:54 INFO - PROCESS | 2184 | A coding exception was thrown and uncaught in a Task. 08:53:54 INFO - PROCESS | 2184 | 08:53:54 ERROR - PROCESS | 2184 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:53:54 INFO - PROCESS | 2184 | Full stack: 08:53:54 INFO - PROCESS | 2184 | ************************* 08:55:13 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:55412/tests/dromaeo/cssquery-ext.html (next: http://localhost:55412/tests/dromaeo/cssquery-jquery.html) 08:55:13 INFO - PROCESS | 2184 | RSS: Main: 355995648 08:55:13 INFO - PROCESS | 2184 | 08:58:16 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:55412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55412/tests/dromaeo/cssquery-mootools.html) 08:58:16 INFO - PROCESS | 2184 | RSS: Main: 347779072 08:58:16 INFO - PROCESS | 2184 | 09:01:19 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:55412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55412/tests/dromaeo/cssquery-prototype.html) 09:01:19 INFO - PROCESS | 2184 | RSS: Main: 322617344 09:01:19 INFO - PROCESS | 2184 | 09:04:23 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:55412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55412/tests/dromaeo/cssquery-yui.html) 09:04:23 INFO - PROCESS | 2184 | RSS: Main: 322711552 09:04:23 INFO - PROCESS | 2184 | 09:07:27 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:55412/tests/dromaeo/cssquery-yui.html (next: http://localhost:55412/tests/dromaeo/cssquery-dojo.html) 09:07:27 INFO - PROCESS | 2184 | RSS: Main: 386695168 09:07:27 INFO - PROCESS | 2184 | 09:07:27 INFO - PROCESS | 2184 | __start_tp_report 09:07:27 INFO - PROCESS | 2184 | _x_x_mozilla_page_load 09:07:27 INFO - PROCESS | 2184 | _x_x_mozilla_page_load_details 09:07:27 INFO - PROCESS | 2184 | |i|pagename|runs| 09:07:27 INFO - PROCESS | 2184 | |0;dojo.html;2723.183045086474;3189.266468712197;3194.6006749156354;3214.357128574283;3244.2051697334155;5413;5429;5446.074167391543;5457.617966742329;5458.4814442627985;5420.891582168354;5468.152436372358;5482.5613950883935;5484.149956756709;5494.09347457669;5026.120428924951;5027.120253955562;5094.032133894567;5116.386033675964;5158.664686795365;4271.572842715719;4960.33035540201;4976.776045077981;4988.251762235657;5012.548870601645;4999.275105109775;5027.09512287788;5075.035743208797;5075.086484432801;5079.23811428285;5105.132127538327;5118.923216151761;5126.154184559543;5126.948730512684;5150.690958542462;4935.3090567320605;5029.346184995927;5053.84838454847;5066.923996140061;5070.8225212117395;5327.733613319358;5429.728513574345;5440.156775699773;5444.863878403072;5458.645188062763;5840.386759390245;5911.349751527328;5912.260967379078;5921.319048309413;5933.940660593382;5962.70186490678;6019.849503762397;6021.458068773788;6029.186059881904;6053.122297266916;5558.388577256498;5567.2762540869835;5568.331800184003;5574.136008918624;5577.358603760538;6093.6039157454625;6124.319907527392;6132.703928623082;6174.9073763893575;6190.597611155351;5843;5860.443257890493;5864.296284445809;5867.794627188028;5874.236349274567;5832.533397328203;6034.939650603438;6045.3652366501765;6051.576389652682;6072.483838873657;5808.564357673192;5861.736221870026;5868.794592189338;5877.324107727581;5888.175655408247;5870.501007414332;5900.793472228452;5909.143174239711;5915.733791979371;5919.615225010447;4716.551927566876;4833.709977401367;4838.056578967067;4838.782254798542;4848.12733707936;3894.844206231776;4087.426340858791;4152.231837110145;4368.650507959355;4382.189294980439;4747.335373047776;5437.728113594305;5485.341758988947;5502.944970550323;5509.889802203934;6055.6063855849225;6059.484943779828;6060.090986352083;6066.545009124245;6071.7571297147615;5287.9471205287455;5361.785528578891;5364.249005139283;5427.48438898304;5450.618456707993;5166.225066240094;5243.082460569462;5243.895122097537;5246.711430871339;5273.525382715574;6100.755969761338;6142.9078563820685;6185.134081228632;6193.040078787795;6204.844878878064;5956.13636022783;5996.400359963969;6008.669523176092;6033.728482218398;6052.878942421039;6061.969690151521;6235.251769787655;6240.219972503437;6241.937580624136;6249.437550620466;5674.858128546819;5752.482276594959;5758.798442054508;5777.133429985536;5878.29460464747;5805.071188609802;5932.8813423732145;5945.762169513171;5951.196588460675;5952.642841429528;5725;5734.05388110957;5741;5745.080787074048;5753.3958934311295;5584.106542953271;5662.122371032497;5697.886042279214;5733.541316694571;5749.8275051748515;5657.632253903483;5658.9151162733415;5659.688717120598;5666.093425051972;5697.259356283656;5766.682832444256;5788.450097240755;5792.044312688359;5802.245708057925;5802.47777700009;5551.167324901297;5569.220309156641;5578.107502799533;5630.8029218977135;5645.915311270416 09:07:27 INFO - PROCESS | 2184 | |1;ext.html;492.8570714492797;502.785772359751;506.61244148226615;508.6439492355352;542.8154427494651;31252.374952500937;40408.989775255635;42710.7864460678;42734.35898461525;44622.55377446225;43317.35023974643;43856.3421548677;44102.779486102605;44177.67466975988;44237.11525769483;8371.748847534584;9206.171444570004;9420.340576159671;9427;9433.151016408521;8369.455985360963;11094.223404361697;11324.15068869838;11329.433528323592;11532.135089868252;11302.095832333434;11372.203945723802;11376.317420954769;11386.544538218503;11394;8477.321814254845;11207.831882521768;11280.210385273034;11286.830697539543;11300;8451.45065570736;8473.745787626382;11166.162537809616;11208.327500349924;11369.886301136965;40587.18825623471;41100.79449602763;41531.96170095772;41537.169256615;41631;3943.3296339622334;3980.2835489611857;3996.860109896169;4013.759174449513;4019.1157945252;29631.851840740874;29691.109266722033;29710.40579188426;30500.08499745011;30603.387932241454;3021.380616973537;3298.175456135966;3304.1574398528223;3370.1069216657606;3380.9492857607156;431060;431207;432797;432952;433361.8331908352;61273.693631531554;61936.76126477445;62002;62140;62147;64603.67698161479;65997.34002659912;66020;66117.00824487637;66200.67598648;16465.753013704805;16669.583260418585;16676.416325428552;16700;16715.498535043967;11686.006689431324;11926.224795388272;12884.80672789909;12963.546275880299;12994.090413671142;12577.371131443391;14567.635809104857;17006.48980530586;17219.65560688779;17806.55483612894;4996.850094497171;6862.725490980405;6878.621675807779;6890.483213758988;6938.83057122447;868.6351732272461;878.2271600991087;888.9333300002526;904.7692838326185;915.6291701860757;30054;30158.095257142322;30338.02718403919;30475.93334233291;30875.536866947015;1046.1055797293357;1050.9842352364722;1093.371311495893;1107.9224454288124;1202.6271855724578;13480;15206.16366099875;15547.533573992798;15657.686846263012;15801.130937798302;523461;528300;528525;529220;529799;59965.70017149974;60123.09815352773;60246.39753602495;60481.39518604846;60720.696396518615;1442.5528086293282;1442.581651321105;1462.8829693624484;1465.0477189826697;1468.6328417895527;28471.28821779389;29244.853775731837;29814.70185298206;30391.240218994702;30392.240193995327;50624.49375506198;51006.48993510017;51150;51194.48805512046;51198.99999999851;489525;490497;491096;491888;491966;40019.599804002755;40380.59619403768;41035.7948210257;41245;41334.37998430086;46117.76941115273;46972.530274696815;47184.820379489414;47758.522414775405;47883.521164787904;33049.33901322008;38138.61861381351;38357.424638629884;38593;39031;37951.81024094862;38905.99583132202;39210.803945980086;39559.81320560388;39940.80177594677;36601.63398365982;37308.25383492369;37988.81005595065;38016.23967520579;38514.8445546634;32480;33491.66508334885;34228.657713422544;34328.82835585806;34557.65442345645;24599.38501537476;24696.876515617307;24951.87524062368;25182.7003713913;25317.620235696846 09:07:27 INFO - PROCESS | 2184 | |2;jquery.html;368.98893033209015;378.5608693915059;380.5395471479511;401.2877143071049;427.06259759827174;14873.553793386202;15183.937124401282;18450.723239151408;20330.49173770653;20518;21275.680864787002;21289;21846.45383865404;21863;21950.012249448773;5029.698218106916;5686.658800471964;5762.135679648065;5765.538756899459;5892.587518873681;5411.242426060355;5784;5788.5658575606785;5790.913136302937;5802.274715660543;4110.506739191302;4321.286987647034;6058.485028772538;6329.05064240363;6374.585651932633;6223.471004964584;6412.615243085406;6417.294097649255;6425.164728585254;6463.612183268995;5684.772609095672;5685.829425117253;5692.37383887772;5697.116946873241;5701.657900525982;25855.482890342275;26060.478790424084;26093.608595871076;26104.73895261042;26381.868090659424;2666.4533770576986;2761.254461295439;2764.8617569121666;2766.7233276672373;2767.8892844286206;15290.770638440432;15362;15467.767983480144;15628.296726647328;15769.684606307925;1730.7144321186988;1776.8845025073329;1778.439791465697;1796.4341232511717;1807.159670753093;87252;109997.90002099957;113033;113220.43389783081;114676.85323146745;11086.113110951104;11269;11337.716557085974;11382.658520244406;11486.827697584544;14333.78499322511;14376.928115359357;14386.496472623408;14397.78403323951;14398.280085995868;7070.858582828315;8264.462809917337;8397.202265784741;8636.524991125423;8663.696770612998;7190.820229494305;8526.40315177944;8560.743177704679;8751.387402881865;8759.824803503894;7010.964945175241;7103.822404439827;7118.394936430358;7137.179224389158;7141.214466408691;1889.1970912362465;1932.8692714761742;1933.5359513716887;1936.0997136331673;1938.5832046110154;378.3700139268143;383.65854389593284;385.7415531593839;1016.5628779624832;1085.8588383510094;9213.493257870747;11683.357415342238;12008.339541325136;12076.818847717292;12090.455929483194;351.2781234562947;408.7363650445446;419.79010494752623;423.8474149306247;425.1497005988024;4506.662000349987;5211.244369566468;6091.116788065706;6145.907811382833;6287.276963149205;621206;627795.8610206919;642798;758054;765524;156117.4388256103;158664.41335586726;160822;162713.18643406944;164589.17705411397;437.31560108430205;457.2820671545641;457.36654733194763;460.05917897898877;460.82718980382356;10138.884722680647;11077.169212308949;11162.716287627027;11578.247413918069;11704.590339338083;57731.4226857726;59005.704971474865;60185;61622.69188654028;61902.69048654728;80701.59649201717;83763.16236837553;85140;85990;86902;8172.42793004484;8180.46826956246;8183.468074575134;8223.204110602424;8319.750407487785;12623.747525049632;12650.746985060063;12665.746685066431;12838.29389383593;13253.86746132565;10970.890291097307;11041.72395690082;11143.375499167754;11201.271917325348;11286.943565282449;11166.888331116585;11293.604723834625;11358.26171298863;11467.4266286687;11590.652280431601;11313.981741643292;11512.791156928402;11593.362365069665;11612.6516204514;11782.469788859693;8243.299319557906;8323.292520135856;8460.788480287796;8553.059163491886;8564.828703426021;9411.576479058596;10662.8400573993;10765.677029689123;11060.446977650925;11225.775484490428 09:07:27 INFO - PROCESS | 2184 | |3;mootools.html;1417.433026789285;1442.8052212951247;1454.4691187716483;1458.5041086030753;1470.5000299898034;8098.2306680865295;8509.659613615448;8523.57382130894;8541.402101852873;8542.95728521358;7455.403567714583;7667.616619169047;7671.23287671234;8068.152843951389;8307.08622051574;2287.5196208796133;2331.5103828196097;2333.614953532665;2338.649202619604;2339.3917581428864;2306.9769302307013;2336.7195936487647;2346.5424242272766;2354.0819080558595;2356.646503024543;2303.9884800576056;2319.3273950554317;2341.028473183627;2345.847519911209;2350.095213342858;2289.3132060381986;2291.232437133554;2315.9421014474688;2318.9188378406675;2320.385097949028;2272.8295377846725;2346.2257455039967;2346.6949296591506;2351.2946116165253;2351.8471299365488;8396.244338009608;8454.323654107657;8462.15378462155;8475.194856488624;8492.108328625467;5019.3976722793495;5169.586433085382;5183.50756678115;5185;5200;3249.2526718854797;3391.2369716813764;3602.621724718893;3605.4952306677087;3608.025833025095;1193.8985186259179;1220.9816852747215;1242.2670624331597;1244.9538998255669;1260.3950103950065;10861.511231994578;10904.454777261106;10959.945200273947;10984.121270298358;10989.285696429786;4397.36238245459;4625.930611040837;4715.0805592909055;4715.127701375257;4716.575508204278;9541.522923853918;9570.138687518156;9571.760705982406;9578.13796758295;9584.856227156599;5252.395974462986;5253.474652534716;5255.658382205144;5257.737113144404;5265.473452654781;3933.350997085506;4180.853670121531;4684.133435314409;4690.226112691368;4792.161371759928;3209.261869769966;3847.5382954045135;3914.2954268231993;3972.0268534208726;3973.8410463581713;1264.304632452166;1272.4401263444056;1281.1992504684572;1285.0554842190982;1291.7416516696699;777.0791611939869;845.7547311279783;893.7006102955582;905.8324210021167;907.3920473282916;5091.261767043832;5423.267858839085;5544.473275038865;5607.579431542651;5796.362400135981;901.9052999435096;915.0757734688013;975.9853602195973;1002.964896228643;1017.211660962745;3059.709327613873;3452.1197094740683;3529.170644898447;3679.6688298053305;3681.889543313705;9750.512474376254;10058.346207496636;10101.494925253708;10116.140128089048;10140;9971.501424928725;9996.300258981946;10013;10125.291229613857;10167.694969150938;7787.610619469004;7882.960585197037;7965.362770978308;7966.960165199137;7976.680932762741;4653.488116307271;4737.407824021997;5256.290400795997;5319.494648008433;5394.595405344537;9000.774980625536;9067.909320906707;9205.815883682422;9291.349605527548;9304.16262536375;9147.451152930846;9254.213391861767;9438.339316248072;9555.331126821056;9568.665096721581;6235.345288744798;6411.647359395091;6445.323241059808;6683.8997415039785;6716.093327400934;7714.1128770192145;7972.521648701097;7987.800304992422;8047.476914000571;8080.9191908080165;6930;7124.465665075244;7149.857002860018;7221.67502462401;7244.4566657499845;6813.795586132225;6988.808347936864;7026.8945965809535;7042.22535521082;7103.786886393416;5292.788288468418;6331.2085989251345;6373.012183111625;6382.106505089384;6390.105385245976;4853.611711063036;4858.1012512685265;4891.144049791201;4929.926051109164;4937.654364194472;4299.376590394438;4551.907542189917;4787.42550893895;4840.152973229741;4992 09:07:27 INFO - PROCESS | 2184 | |4;prototype.html;351.5587937138891;356.9875054373097;360.812377563667;372.9627037296269;372.97762134271926;4189.706720529564;4570.794314255858;4831.68594041387;5196.688198708081;5200.843974680761;4880.170371036923;4984.22744474607;4995.375578052744;5001.59987201024;5022.974885125569;3767.6420740029653;4074.470318858544;4086.7139300248996;4089.652379547742;4092.3247664135383;3904.2777086238993;4093.038136038029;4102.179564087194;4113.136241389312;4118;3280.967190328102;3898.7660740355527;3992.8837716010416;4023.879283621496;4045.965525855608;3936.9803150984203;4035.3543433050572;4047.6357127858632;4049.6152865477734;4059.6143366380293;3036.5900603418477;3204.3337464518554;3636.945445818315;3652.2695460907926;3659.505966694489;4238.91522169558;4253.29820579604;4487.887802804923;4630.865437967719;5119.616028797818;4090.018395585038;4278.358246263055;4370.606645401929;4708.929366059512;4722.709485899336;4811.49479304675;5452.836414907559;5475.439499742594;5489.917651235235;5560.443955604448;3620.6560376764164;4019.1311040366077;4024.879253622396;4025.174839157995;4032.185516517579;4517.774111294455;4867.539738078563;4989.301497790312;5529.861753456155;5645.237892884449;3442.294329662413;4069.674426045909;4090.5661131626634;4103.384492326175;4117.691173161965;3653.7394598863348;4151.712968979626;4162.292410290258;4173.83304667816;4175.457190565207;4491.169133710274;4606.262997920384;4644.9767751161025;4717.457492388351;4793.209120495149;4837.588804951619;5221.269022336875;5406.83779486616;5440.727963601883;5464.23500709901;1176.894079532829;1201.5133870782347;1328.946842126304;1336.1027341175554;1358.4634069542476;745.2026331824895;951.8239125761756;953.6280850468323;965.6282331302499;969.2294625772528;4418.293073108352;4459.420275364182;4464.709793863389;4479.664025198123;4726.605651332865;4918.401519506175;5099.59203263738;5236.450172731885;5240.502152295526;5252.369715634072;3810.942835857464;4719.457262414798;4724.740139292303;4732.02993386355;4867.58625516835;2290.473191166041;2388.3312672451743;2490.306591517749;2581;2730.2662809116355;4501.527339629357;4802.063597598435;4904.185451383011;5212.166053431432;5408.702521361363;4772.880677983078;5169.327987361619;5384.799856112239;5386.757595908193;5407.864803379868;4915;5028.1144570785955;5176.903354141578;5343.866403339947;5441.401445840955;4640.767961601974;5266.8419947401635;5296.947030529645;5329.760160792696;5333.546648534918;4679.823881894935;4847.321375007431;4861.878453038561;4914.434839993303;5157.802162659175;4737.8341758038305;4791.904161916673;5444.080262211201;5449.501387118574;5460.096031337613;3584.426491761306;3801.9239615208094;3808.295465338921;3822.4075268333454;3824.2733880562605;4403.8018289176425;4837.588804951478;5235.738213089407;5240.764165612481;5279.445658205833;4176.832926682899;4211.94633890427;5074.340335756328;5079.568236699922;5116.846494605168;4730.455997560324;5084.186530155157;5126.4364368867855;5144.511271429208;5156.639035267495;4581.67131531852;4939.876503087452;4957.429895561912;4964.578010868972;5013.420772456664;4207.6423504002505;4714.693544919569;4840.419149702058;4919.483454237254;5006.774695138654;4133.669306455537;4414.801333940045;4966.701997880139;4984.106039704889;5028.673136246132 09:07:27 INFO - PROCESS | 2184 | |5;yui.html;665.5108495255982;700.7792545348215;734.8126227811907;799.7840583042579;808.2402541610884;14475.782863257047;15524.611884702888;15531.145786981726;15560.53318400447;15565.766513502307;14025.088369255991;14079.57761267161;14362.425502979868;14406.207658578774;14607.342669579868;820.0774129104757;854.4232642966005;855.7432770168956;856.0754385263931;856.0882659967147;843.527624530262;844.0377969115214;846.0101681033206;846.3018010141627;847.690592933581;711.5766119159092;737.5353527277834;740.1894925057054;741.9035525381693;905.2983937448497;905.8143080668447;906.8775715278485;907.3557773980482;907.9001309855911;907.9228265597433;673.3535805626605;673.4040374268808;674.4739103499278;674.5750177388214;675.0481820632884;12033.338166400845;12491;14553.563393098224;15088.924555377263;15297.770533442008;14335.42658293667;14518.491852785102;14521.273936303249;14523.927380363137;14568.781468277984;10861.619843305447;10942.617008404668;11088.390138542378;11660.883391166064;12000.759984800343;3702.129999450127;3704.74066815323;3717.9628203718157;3749.3063783200196;3869.303525365433;101196.9880301195;108940.45529772379;110650;110829.44585277022;112762.43618781936;10031.197504199647;10872.510737016853;10946.781064378667;11193.776124477465;11360.659180224606;22529.549409011728;22676.88661556682;23009.769902300763;23018.539629207324;23023.19418820333;6997.160340759141;7449.88825167623;7888;7922.207779222147;8098.878516822252;4199.685023623179;4346.1090476452255;4350.1734670412525;4493.258612328995;4523.705959112647;3586.8923932282073;3627.546556680415;3649.708023358125;3693.9261214776093;3701.4632878232505;672.67711498481;672.6838385958591;679.0222080204489;679.1374953808636;683.702589373624;555.9805406810742;624.5472032776291;659.3768888400512;662.5627086123231;666.4901350466897;8749.387542872066;9515.619375225051;9591.328606997582;10048.79902401948;10224.335418197794;505.7597641120512;512.50799232737;541.9024575576356;625.1872565664618;670.8911637877527;4535;4948.925766113512;4961.6030717543235;4970.527799859007;4975.278584605212;77268;94932.57601135988;96486;96509;96967.51516242373;83490;84556;85061.57469212615;87887.1211287879;88908;73855;75357.62321188359;75843;76046.85929711058;77815.83276250861;7895;9320.627174912928;9364.391314564531;9432.386894851812;9498.572564234488;36347.54609815578;40733;43937.56062439334;48108;49904.75238119076;48774.756126219145;65044;65091.67454162699;66433.66783166054;67540.6622966882;11476.827847582126;11513.769724605294;11661.883381166079;11730.648080557597;11775.76448471043;11988.580399685969;12564;12576.811347829973;12633.052521061141;12756.107072504836;11330.546778128783;11679;11794.882051179378;11894.226875253082;12012.039036877204;10012.599496020077;11133;11869.109816763605;11988.76022479563;12280.263184208976;11023.61417350389;11825.645230643095;12189;12190.08574356909;12318.137730358789;9233.538323083685;9460.432374057578;9765.609375624896;9772.413655180711;9905.405675659484;6145.877082458415;8372.581370931308;9475.810483790423;9541.761455963657;9541.809163816824 09:07:27 INFO - PROCESS | 2184 | __end_tp_report 09:07:27 INFO - PROCESS | 2184 | __start_cc_report 09:07:27 INFO - PROCESS | 2184 | _x_x_mozilla_cycle_collect,1481 09:07:27 INFO - PROCESS | 2184 | __end_cc_report 09:07:27 INFO - PROCESS | 2184 | __startTimestamp1487264847514__endTimestamp 09:07:27 INFO - PROCESS | 2184 | 09:07:27 INFO - PROCESS | 2184 | ------- Summary: start ------- 09:07:27 INFO - PROCESS | 2184 | Number of tests: 6 09:07:27 INFO - PROCESS | 2184 | 09:07:27 INFO - PROCESS | 2184 | [#0] dojo.html Cycles:165 Average:5496.82 Median:5658.92 stddev:629.64 (11.1%) stddev-sans-first:592.79 09:07:27 INFO - PROCESS | 2184 | Values: 2723.2 3189.3 3194.6 3214.4 3244.2 5413.0 5429.0 5446.1 5457.6 5458.5 5420.9 5468.2 5482.6 5484.1 5494.1 5026.1 5027.1 5094.0 5116.4 5158.7 4271.6 4960.3 4976.8 4988.3 5012.5 4999.3 5027.1 5075.0 5075.1 5079.2 5105.1 5118.9 5126.2 5126.9 5150.7 4935.3 5029.3 5053.8 5066.9 5070.8 5327.7 5429.7 5440.2 5444.9 5458.6 5840.4 5911.3 5912.3 5921.3 5933.9 5962.7 6019.8 6021.5 6029.2 6053.1 5558.4 5567.3 5568.3 5574.1 5577.4 6093.6 6124.3 6132.7 6174.9 6190.6 5843.0 5860.4 5864.3 5867.8 5874.2 5832.5 6034.9 6045.4 6051.6 6072.5 5808.6 5861.7 5868.8 5877.3 5888.2 5870.5 5900.8 5909.1 5915.7 5919.6 4716.6 4833.7 4838.1 4838.8 4848.1 3894.8 4087.4 4152.2 4368.7 4382.2 4747.3 5437.7 5485.3 5502.9 5509.9 6055.6 6059.5 6060.1 6066.5 6071.8 5287.9 5361.8 5364.2 5427.5 5450.6 5166.2 5243.1 5243.9 5246.7 5273.5 6100.8 6142.9 6185.1 6193.0 6204.8 5956.1 5996.4 6008.7 6033.7 6052.9 6062.0 6235.3 6240.2 6241.9 6249.4 5674.9 5752.5 5758.8 5777.1 5878.3 5805.1 5932.9 5945.8 5951.2 5952.6 5725.0 5734.1 5741.0 5745.1 5753.4 5584.1 5662.1 5697.9 5733.5 5749.8 5657.6 5658.9 5659.7 5666.1 5697.3 5766.7 5788.5 5792.0 5802.2 5802.5 5551.2 5569.2 5578.1 5630.8 5645.9 09:07:27 INFO - PROCESS | 2184 | 09:07:27 INFO - PROCESS | 2184 | [#1] ext.html Cycles:180 Average:63798.35 Median:21751.57 stddev:128811.05 (592.2%) stddev-sans-first:129084.70 09:07:27 INFO - PROCESS | 2184 | Values: 492.9 502.8 506.6 508.6 542.8 31252.4 40409.0 42710.8 42734.4 44622.6 43317.4 43856.3 44102.8 44177.7 44237.1 8371.7 9206.2 9420.3 9427.0 9433.2 8369.5 11094.2 11324.2 11329.4 11532.1 11302.1 11372.2 11376.3 11386.5 11394.0 8477.3 11207.8 11280.2 11286.8 11300.0 8451.5 8473.7 11166.2 11208.3 11369.9 40587.2 41100.8 41532.0 41537.2 41631.0 3943.3 3980.3 3996.9 4013.8 4019.1 29631.9 29691.1 29710.4 30500.1 30603.4 3021.4 3298.2 3304.2 3370.1 3380.9 431060.0 431207.0 432797.0 432952.0 433361.8 61273.7 61936.8 62002.0 62140.0 62147.0 64603.7 65997.3 66020.0 66117.0 66200.7 16465.8 16669.6 16676.4 16700.0 16715.5 11686.0 11926.2 12884.8 12963.5 12994.1 12577.4 14567.6 17006.5 17219.7 17806.6 4996.9 6862.7 6878.6 6890.5 6938.8 868.6 878.2 888.9 904.8 915.6 30054.0 30158.1 30338.0 30475.9 30875.5 1046.1 1051.0 1093.4 1107.9 1202.6 13480.0 15206.2 15547.5 15657.7 15801.1 523461.0 528300.0 528525.0 529220.0 529799.0 59965.7 60123.1 60246.4 60481.4 60720.7 1442.6 1442.6 1462.9 1465.0 1468.6 28471.3 29244.9 29814.7 30391.2 30392.2 50624.5 51006.5 51150.0 51194.5 51199.0 489525.0 490497.0 491096.0 491888.0 491966.0 40019.6 40380.6 41035.8 41245.0 41334.4 46117.8 46972.5 47184.8 47758.5 47883.5 33049.3 38138.6 38357.4 38593.0 39031.0 37951.8 38906.0 39210.8 39559.8 39940.8 36601.6 37308.3 37988.8 38016.2 38514.8 32480.0 33491.7 34228.7 34328.8 34557.7 24599.4 24696.9 24951.9 25182.7 25317.6 09:07:27 INFO - PROCESS | 2184 | 09:07:27 INFO - PROCESS | 2184 | [#2] jquery.html Cycles:180 Average:37941.98 Median:373.68 stddev:114666.17 (30685.7%) stddev-sans-first:114953.14 09:07:27 INFO - PROCESS | 2184 | Values: 369.0 378.6 380.5 401.3 427.1 14873.6 15183.9 18450.7 20330.5 20518.0 21275.7 21289.0 21846.5 21863.0 21950.0 5029.7 5686.7 5762.1 5765.5 5892.6 5411.2 5784.0 5788.6 5790.9 5802.3 4110.5 4321.3 6058.5 6329.1 6374.6 6223.5 6412.6 6417.3 6425.2 6463.6 5684.8 5685.8 5692.4 5697.1 5701.7 25855.5 26060.5 26093.6 26104.7 26381.9 2666.5 2761.3 2764.9 2766.7 2767.9 15290.8 15362.0 15467.8 15628.3 15769.7 1730.7 1776.9 1778.4 1796.4 1807.2 87252.0 109997.9 113033.0 113220.4 114676.9 11086.1 11269.0 11337.7 11382.7 11486.8 14333.8 14376.9 14386.5 14397.8 14398.3 7070.9 8264.5 8397.2 8636.5 8663.7 7190.8 8526.4 8560.7 8751.4 8759.8 7011.0 7103.8 7118.4 7137.2 7141.2 1889.2 1932.9 1933.5 1936.1 1938.6 378.4 383.7 385.7 1016.6 1085.9 9213.5 11683.4 12008.3 12076.8 12090.5 351.3 408.7 419.8 423.8 425.1 4506.7 5211.2 6091.1 6145.9 6287.3 621206.0 627795.9 642798.0 758054.0 765524.0 156117.4 158664.4 160822.0 162713.2 164589.2 437.3 457.3 457.4 460.1 460.8 10138.9 11077.2 11162.7 11578.2 11704.6 57731.4 59005.7 60185.0 61622.7 61902.7 80701.6 83763.2 85140.0 85990.0 86902.0 8172.4 8180.5 8183.5 8223.2 8319.8 12623.7 12650.7 12665.7 12838.3 13253.9 10970.9 11041.7 11143.4 11201.3 11286.9 11166.9 11293.6 11358.3 11467.4 11590.7 11314.0 11512.8 11593.4 11612.7 11782.5 8243.3 8323.3 8460.8 8553.1 8564.8 9411.6 10662.8 10765.7 11060.4 11225.8 09:07:27 INFO - PROCESS | 2184 | 09:07:27 INFO - PROCESS | 2184 | [#3] mootools.html Cycles:180 Average:5399.72 Median:5005.70 stddev:2975.10 (59.4%) stddev-sans-first:2968.39 09:07:27 INFO - PROCESS | 2184 | Values: 1417.4 1442.8 1454.5 1458.5 1470.5 8098.2 8509.7 8523.6 8541.4 8543.0 7455.4 7667.6 7671.2 8068.2 8307.1 2287.5 2331.5 2333.6 2338.6 2339.4 2307.0 2336.7 2346.5 2354.1 2356.6 2304.0 2319.3 2341.0 2345.8 2350.1 2289.3 2291.2 2315.9 2318.9 2320.4 2272.8 2346.2 2346.7 2351.3 2351.8 8396.2 8454.3 8462.2 8475.2 8492.1 5019.4 5169.6 5183.5 5185.0 5200.0 3249.3 3391.2 3602.6 3605.5 3608.0 1193.9 1221.0 1242.3 1245.0 1260.4 10861.5 10904.5 10959.9 10984.1 10989.3 4397.4 4625.9 4715.1 4715.1 4716.6 9541.5 9570.1 9571.8 9578.1 9584.9 5252.4 5253.5 5255.7 5257.7 5265.5 3933.4 4180.9 4684.1 4690.2 4792.2 3209.3 3847.5 3914.3 3972.0 3973.8 1264.3 1272.4 1281.2 1285.1 1291.7 777.1 845.8 893.7 905.8 907.4 5091.3 5423.3 5544.5 5607.6 5796.4 901.9 915.1 976.0 1003.0 1017.2 3059.7 3452.1 3529.2 3679.7 3681.9 9750.5 10058.3 10101.5 10116.1 10140.0 9971.5 9996.3 10013.0 10125.3 10167.7 7787.6 7883.0 7965.4 7967.0 7976.7 4653.5 4737.4 5256.3 5319.5 5394.6 9000.8 9067.9 9205.8 9291.3 9304.2 9147.5 9254.2 9438.3 9555.3 9568.7 6235.3 6411.6 6445.3 6683.9 6716.1 7714.1 7972.5 7987.8 8047.5 8080.9 6930.0 7124.5 7149.9 7221.7 7244.5 6813.8 6988.8 7026.9 7042.2 7103.8 5292.8 6331.2 6373.0 6382.1 6390.1 4853.6 4858.1 4891.1 4929.9 4937.7 4299.4 4551.9 4787.4 4840.2 4992.0 09:07:27 INFO - PROCESS | 2184 | 09:07:27 INFO - PROCESS | 2184 | [#4] prototype.html Cycles:180 Average:4258.45 Median:4718.46 stddev:1222.47 (25.9%) stddev-sans-first:1190.21 09:07:27 INFO - PROCESS | 2184 | Values: 351.6 357.0 360.8 373.0 373.0 4189.7 4570.8 4831.7 5196.7 5200.8 4880.2 4984.2 4995.4 5001.6 5023.0 3767.6 4074.5 4086.7 4089.7 4092.3 3904.3 4093.0 4102.2 4113.1 4118.0 3281.0 3898.8 3992.9 4023.9 4046.0 3937.0 4035.4 4047.6 4049.6 4059.6 3036.6 3204.3 3636.9 3652.3 3659.5 4238.9 4253.3 4487.9 4630.9 5119.6 4090.0 4278.4 4370.6 4708.9 4722.7 4811.5 5452.8 5475.4 5489.9 5560.4 3620.7 4019.1 4024.9 4025.2 4032.2 4517.8 4867.5 4989.3 5529.9 5645.2 3442.3 4069.7 4090.6 4103.4 4117.7 3653.7 4151.7 4162.3 4173.8 4175.5 4491.2 4606.3 4645.0 4717.5 4793.2 4837.6 5221.3 5406.8 5440.7 5464.2 1176.9 1201.5 1328.9 1336.1 1358.5 745.2 951.8 953.6 965.6 969.2 4418.3 4459.4 4464.7 4479.7 4726.6 4918.4 5099.6 5236.5 5240.5 5252.4 3810.9 4719.5 4724.7 4732.0 4867.6 2290.5 2388.3 2490.3 2581.0 2730.3 4501.5 4802.1 4904.2 5212.2 5408.7 4772.9 5169.3 5384.8 5386.8 5407.9 4915.0 5028.1 5176.9 5343.9 5441.4 4640.8 5266.8 5296.9 5329.8 5333.5 4679.8 4847.3 4861.9 4914.4 5157.8 4737.8 4791.9 5444.1 5449.5 5460.1 3584.4 3801.9 3808.3 3822.4 3824.3 4403.8 4837.6 5235.7 5240.8 5279.4 4176.8 4211.9 5074.3 5079.6 5116.8 4730.5 5084.2 5126.4 5144.5 5156.6 4581.7 4939.9 4957.4 4964.6 5013.4 4207.6 4714.7 4840.4 4919.5 5006.8 4133.7 4414.8 4966.7 4984.1 5028.7 09:07:27 INFO - PROCESS | 2184 | 09:07:27 INFO - PROCESS | 2184 | [#5] yui.html Cycles:180 Average:19436.89 Median:4972.90 stddev:28322.33 (569.5%) stddev-sans-first:28366.71 09:07:27 INFO - PROCESS | 2184 | Values: 665.5 700.8 734.8 799.8 808.2 14475.8 15524.6 15531.1 15560.5 15565.8 14025.1 14079.6 14362.4 14406.2 14607.3 820.1 854.4 855.7 856.1 856.1 843.5 844.0 846.0 846.3 847.7 711.6 737.5 740.2 741.9 905.3 905.8 906.9 907.4 907.9 907.9 673.4 673.4 674.5 674.6 675.0 12033.3 12491.0 14553.6 15088.9 15297.8 14335.4 14518.5 14521.3 14523.9 14568.8 10861.6 10942.6 11088.4 11660.9 12000.8 3702.1 3704.7 3718.0 3749.3 3869.3 101197.0 108940.5 110650.0 110829.4 112762.4 10031.2 10872.5 10946.8 11193.8 11360.7 22529.5 22676.9 23009.8 23018.5 23023.2 6997.2 7449.9 7888.0 7922.2 8098.9 4199.7 4346.1 4350.2 4493.3 4523.7 3586.9 3627.5 3649.7 3693.9 3701.5 672.7 672.7 679.0 679.1 683.7 556.0 624.5 659.4 662.6 666.5 8749.4 9515.6 9591.3 10048.8 10224.3 505.8 512.5 541.9 625.2 670.9 4535.0 4948.9 4961.6 4970.5 4975.3 77268.0 94932.6 96486.0 96509.0 96967.5 83490.0 84556.0 85061.6 87887.1 88908.0 73855.0 75357.6 75843.0 76046.9 77815.8 7895.0 9320.6 9364.4 9432.4 9498.6 36347.5 40733.0 43937.6 48108.0 49904.8 48774.8 65044.0 65091.7 66433.7 67540.7 11476.8 11513.8 11661.9 11730.6 11775.8 11988.6 12564.0 12576.8 12633.1 12756.1 11330.5 11679.0 11794.9 11894.2 12012.0 10012.6 11133.0 11869.1 11988.8 12280.3 11023.6 11825.6 12189.0 12190.1 12318.1 9233.5 9460.4 9765.6 9772.4 9905.4 6145.9 8372.6 9475.8 9541.8 9541.8 09:07:27 INFO - PROCESS | 2184 | -------- Summary: end -------- 09:07:27 INFO - PROCESS | 2184 | 09:07:28 INFO - TEST-INFO | 2184: exit 0 09:07:28 INFO - TEST-OK | dromaeo_css | took 1119028ms 09:07:28 INFO - TEST-START | kraken 09:07:28 INFO - operating with platform_type : mac_ 09:07:28 INFO - Initialising browser for kraken test... 09:07:28 INFO - TEST-INFO | started process 2186 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/tmpRx4VrD/profile http://localhost:55412/getInfo.html) 09:07:30 INFO - PROCESS | 2186 | __metrics Screen width/height:1600/1200 09:07:30 INFO - PROCESS | 2186 | colorDepth:24 09:07:30 INFO - PROCESS | 2186 | Browser inner width/height: 1024/689 09:07:30 INFO - PROCESS | 2186 | __metrics 09:07:30 INFO - PROCESS | 2186 | 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" 09:07:30 INFO - PROCESS | 2186 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:31 INFO - TEST-INFO | 2186: exit 0 09:07:31 INFO - Browser initialized. 09:07:31 INFO - Running cycle 1/1 for kraken test... 09:07:31 INFO - TEST-INFO | started process 2187 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/tmpRx4VrD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:43 INFO - PROCESS | 2187 | RSS: Main: 213553152 09:07:43 INFO - PROCESS | 2187 | 09:07:46 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55412/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:47 INFO - PROCESS | 2187 | RSS: Main: 266149888 09:07:47 INFO - PROCESS | 2187 | 09:07:50 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55412/tests/kraken/driver.html?testName=audio-dft) 09:07:50 INFO - PROCESS | 2187 | RSS: Main: 275001344 09:07:50 INFO - PROCESS | 2187 | 09:07:54 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55412/tests/kraken/driver.html?testName=audio-fft) 09:07:54 INFO - PROCESS | 2187 | RSS: Main: 371544064 09:07:54 INFO - PROCESS | 2187 | 09:07:56 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55412/tests/kraken/driver.html?testName=audio-oscillator) 09:07:57 INFO - PROCESS | 2187 | RSS: Main: 275992576 09:07:57 INFO - PROCESS | 2187 | 09:07:59 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:59 INFO - PROCESS | 2187 | RSS: Main: 277323776 09:07:59 INFO - PROCESS | 2187 | 09:08:02 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55412/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:03 INFO - PROCESS | 2187 | RSS: Main: 317353984 09:08:03 INFO - PROCESS | 2187 | 09:08:06 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55412/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:06 INFO - PROCESS | 2187 | RSS: Main: 317923328 09:08:06 INFO - PROCESS | 2187 | 09:08:09 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55412/tests/kraken/driver.html?testName=json-parse-financial) 09:08:10 INFO - PROCESS | 2187 | RSS: Main: 315621376 09:08:10 INFO - PROCESS | 2187 | 09:08:11 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:08:12 INFO - PROCESS | 2187 | RSS: Main: 295251968 09:08:12 INFO - PROCESS | 2187 | 09:08:14 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55412/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:15 INFO - PROCESS | 2187 | RSS: Main: 295493632 09:08:15 INFO - PROCESS | 2187 | 09:08:17 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:17 INFO - PROCESS | 2187 | RSS: Main: 302166016 09:08:17 INFO - PROCESS | 2187 | 09:08:20 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:21 INFO - PROCESS | 2187 | RSS: Main: 316784640 09:08:21 INFO - PROCESS | 2187 | 09:08:24 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:25 INFO - PROCESS | 2187 | RSS: Main: 310505472 09:08:25 INFO - PROCESS | 2187 | 09:08:26 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:55412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55412/tests/kraken/driver.html?testName=ai-astar) 09:08:27 INFO - PROCESS | 2187 | RSS: Main: 354885632 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | __start_tp_report 09:08:27 INFO - PROCESS | 2187 | _x_x_mozilla_page_load 09:08:27 INFO - PROCESS | 2187 | _x_x_mozilla_page_load_details 09:08:27 INFO - PROCESS | 2187 | |i|pagename|runs| 09:08:27 INFO - PROCESS | 2187 | |0;ai-astar;115;113;113;114;114;117;161;170;113;115 09:08:27 INFO - PROCESS | 2187 | |1;audio-beat-detection;143;127;137;187;115;109;110;112;130;110 09:08:27 INFO - PROCESS | 2187 | |2;audio-dft;187;184;183;186;185;186;185;185;184;182 09:08:27 INFO - PROCESS | 2187 | |3;audio-fft;82;61;59;92;59;58;58;58;73;61 09:08:27 INFO - PROCESS | 2187 | |4;audio-oscillator;83;69;86;70;69;69;83;70;70;82 09:08:27 INFO - PROCESS | 2187 | |5;imaging-gaussian-blur;88;85;88;86;88;84;89;86;88;87 09:08:27 INFO - PROCESS | 2187 | |6;imaging-darkroom;94;94;94;95;93;93;94;93;93;94 09:08:27 INFO - PROCESS | 2187 | |7;imaging-desaturate;85;86;85;95;88;85;85;87;87;87 09:08:27 INFO - PROCESS | 2187 | |8;json-parse-financial;54;54;54;55;57;57;57;56;57;57 09:08:27 INFO - PROCESS | 2187 | |9;json-stringify-tinderbox;65;73;84;77;72;70;72;71;71;71 09:08:27 INFO - PROCESS | 2187 | |10;stanford-crypto-aes;84;83;87;83;84;82;86;85;89;84 09:08:27 INFO - PROCESS | 2187 | |11;stanford-crypto-ccm;130;140;183;157;146;152;154;139;179;138 09:08:27 INFO - PROCESS | 2187 | |12;stanford-crypto-pbkdf2;167;165;168;167;214;224;167;165;170;167 09:08:27 INFO - PROCESS | 2187 | |13;stanford-crypto-sha256-iterative;66;66;68;65;65;65;68;78;85;83 09:08:27 INFO - PROCESS | 2187 | __end_tp_report 09:08:27 INFO - PROCESS | 2187 | __start_cc_report 09:08:27 INFO - PROCESS | 2187 | _x_x_mozilla_cycle_collect,2108 09:08:27 INFO - PROCESS | 2187 | __end_cc_report 09:08:27 INFO - PROCESS | 2187 | __startTimestamp1487264907203__endTimestamp 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | ------- Summary: start ------- 09:08:27 INFO - PROCESS | 2187 | Number of tests: 14 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#0] ai-astar Cycles:10 Average:124.50 Median:115.00 stddev:21.75 (18.9%) stddev-sans-first:22.79 09:08:27 INFO - PROCESS | 2187 | Values: 115.0 113.0 113.0 114.0 114.0 117.0 161.0 170.0 113.0 115.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:128.50 stddev:24.10 (18.8%) stddev-sans-first:24.94 09:08:27 INFO - PROCESS | 2187 | Values: 143.0 127.0 137.0 187.0 115.0 109.0 110.0 112.0 130.0 110.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:1.49 (0.8%) stddev-sans-first:1.33 09:08:27 INFO - PROCESS | 2187 | Values: 187.0 184.0 183.0 186.0 185.0 186.0 185.0 185.0 184.0 182.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.00 stddev:12.11 (19.9%) stddev-sans-first:11.40 09:08:27 INFO - PROCESS | 2187 | Values: 82.0 61.0 59.0 92.0 59.0 58.0 58.0 58.0 73.0 61.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.00 stddev:7.31 (9.6%) stddev-sans-first:7.17 09:08:27 INFO - PROCESS | 2187 | Values: 83.0 69.0 86.0 70.0 69.0 69.0 83.0 70.0 70.0 82.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:88.00 stddev:1.60 (1.8%) stddev-sans-first:1.64 09:08:27 INFO - PROCESS | 2187 | Values: 88.0 85.0 88.0 86.0 88.0 84.0 89.0 86.0 88.0 87.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:08:27 INFO - PROCESS | 2187 | Values: 94.0 94.0 94.0 95.0 93.0 93.0 94.0 93.0 93.0 94.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#7] imaging-desaturate Cycles:10 Average:87.00 Median:87.00 stddev:3.02 (3.5%) stddev-sans-first:3.11 09:08:27 INFO - PROCESS | 2187 | Values: 85.0 86.0 85.0 95.0 88.0 85.0 85.0 87.0 87.0 87.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:57.00 stddev:1.40 (2.5%) stddev-sans-first:1.32 09:08:27 INFO - PROCESS | 2187 | Values: 54.0 54.0 54.0 55.0 57.0 57.0 57.0 56.0 57.0 57.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:72.00 stddev:4.97 (6.9%) stddev-sans-first:4.45 09:08:27 INFO - PROCESS | 2187 | Values: 65.0 73.0 84.0 77.0 72.0 70.0 72.0 71.0 71.0 71.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:2.11 (2.5%) stddev-sans-first:2.22 09:08:27 INFO - PROCESS | 2187 | Values: 84.0 83.0 87.0 83.0 84.0 82.0 86.0 85.0 89.0 84.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:153.00 stddev:17.47 (11.4%) stddev-sans-first:16.66 09:08:27 INFO - PROCESS | 2187 | Values: 130.0 140.0 183.0 157.0 146.0 152.0 154.0 139.0 179.0 138.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:167.50 stddev:22.10 (13.2%) stddev-sans-first:23.11 09:08:27 INFO - PROCESS | 2187 | Values: 167.0 165.0 168.0 167.0 214.0 224.0 167.0 165.0 170.0 167.0 09:08:27 INFO - PROCESS | 2187 | 09:08:27 INFO - PROCESS | 2187 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:68.00 stddev:7.92 (11.7%) stddev-sans-first:8.20 09:08:27 INFO - PROCESS | 2187 | Values: 66.0 66.0 68.0 65.0 65.0 65.0 68.0 78.0 85.0 83.0 09:08:27 INFO - PROCESS | 2187 | -------- Summary: end -------- 09:08:27 INFO - PROCESS | 2187 | 09:08:28 INFO - TEST-INFO | 2187: exit 0 09:08:28 INFO - TEST-OK | kraken | took 59995ms 09:08:28 INFO - SUITE-END | took 1179s 09:08:28 INFO - Completed test suite (00:19:39) 09:08:28 INFO - javascript benchmark 09:08:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2723.183045086474, 3189.266468712197, 3194.6006749156354, 3214.357128574283, 3244.2051697334155, 5413.0, 5429.0, 5446.074167391543, 5457.617966742329, 5458.4814442627985, 5420.891582168354, 5468.152436372358, 5482.5613950883935, 5484.149956756709, 5494.09347457669, 5026.120428924951, 5027.120253955562, 5094.032133894567, 5116.386033675964, 5158.664686795365, 4271.572842715719, 4960.33035540201, 4976.776045077981, 4988.251762235657, 5012.548870601645, 4999.275105109775, 5027.09512287788, 5075.035743208797, 5075.086484432801, 5079.23811428285, 5105.132127538327, 5118.923216151761, 5126.154184559543, 5126.948730512684, 5150.690958542462, 4935.3090567320605, 5029.346184995927, 5053.84838454847, 5066.923996140061, 5070.8225212117395, 5327.733613319358, 5429.728513574345, 5440.156775699773, 5444.863878403072, 5458.645188062763, 5840.386759390245, 5911.349751527328, 5912.260967379078, 5921.319048309413, 5933.940660593382, 5962.70186490678, 6019.849503762397, 6021.458068773788, 6029.186059881904, 6053.122297266916, 5558.388577256498, 5567.2762540869835, 5568.331800184003, 5574.136008918624, 5577.358603760538, 6093.6039157454625, 6124.319907527392, 6132.703928623082, 6174.9073763893575, 6190.597611155351, 5843.0, 5860.443257890493, 5864.296284445809, 5867.794627188028, 5874.236349274567, 5832.533397328203, 6034.939650603438, 6045.3652366501765, 6051.576389652682, 6072.483838873657, 5808.564357673192, 5861.736221870026, 5868.794592189338, 5877.324107727581, 5888.175655408247, 5870.501007414332, 5900.793472228452, 5909.143174239711, 5915.733791979371, 5919.615225010447, 4716.551927566876, 4833.709977401367, 4838.056578967067, 4838.782254798542, 4848.12733707936, 3894.844206231776, 4087.426340858791, 4152.231837110145, 4368.650507959355, 4382.189294980439, 4747.335373047776, 5437.728113594305, 5485.341758988947, 5502.944970550323, 5509.889802203934, 6055.6063855849225, 6059.484943779828, 6060.090986352083, 6066.545009124245, 6071.7571297147615, 5287.9471205287455, 5361.785528578891, 5364.249005139283, 5427.48438898304, 5450.618456707993, 5166.225066240094, 5243.082460569462, 5243.895122097537, 5246.711430871339, 5273.525382715574, 6100.755969761338, 6142.9078563820685, 6185.134081228632, 6193.040078787795, 6204.844878878064, 5956.13636022783, 5996.400359963969, 6008.669523176092, 6033.728482218398, 6052.878942421039, 6061.969690151521, 6235.251769787655, 6240.219972503437, 6241.937580624136, 6249.437550620466, 5674.858128546819, 5752.482276594959, 5758.798442054508, 5777.133429985536, 5878.29460464747, 5805.071188609802, 5932.8813423732145, 5945.762169513171, 5951.196588460675, 5952.642841429528, 5725.0, 5734.05388110957, 5741.0, 5745.080787074048, 5753.3958934311295, 5584.106542953271, 5662.122371032497, 5697.886042279214, 5733.541316694571, 5749.8275051748515, 5657.632253903483, 5658.9151162733415, 5659.688717120598, 5666.093425051972, 5697.259356283656, 5766.682832444256, 5788.450097240755, 5792.044312688359, 5802.245708057925, 5802.47777700009, 5551.167324901297, 5569.220309156641, 5578.107502799533, 5630.8029218977135, 5645.915311270416], "value": 5454.448598989589, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.8570714492797, 502.785772359751, 506.61244148226615, 508.6439492355352, 542.8154427494651, 31252.374952500937, 40408.989775255635, 42710.7864460678, 42734.35898461525, 44622.55377446225, 43317.35023974643, 43856.3421548677, 44102.779486102605, 44177.67466975988, 44237.11525769483, 8371.748847534584, 9206.171444570004, 9420.340576159671, 9427.0, 9433.151016408521, 8369.455985360963, 11094.223404361697, 11324.15068869838, 11329.433528323592, 11532.135089868252, 11302.095832333434, 11372.203945723802, 11376.317420954769, 11386.544538218503, 11394.0, 8477.321814254845, 11207.831882521768, 11280.210385273034, 11286.830697539543, 11300.0, 8451.45065570736, 8473.745787626382, 11166.162537809616, 11208.327500349924, 11369.886301136965, 40587.18825623471, 41100.79449602763, 41531.96170095772, 41537.169256615, 41631.0, 3943.3296339622334, 3980.2835489611857, 3996.860109896169, 4013.759174449513, 4019.1157945252, 29631.851840740874, 29691.109266722033, 29710.40579188426, 30500.08499745011, 30603.387932241454, 3021.380616973537, 3298.175456135966, 3304.1574398528223, 3370.1069216657606, 3380.9492857607156, 431060.0, 431207.0, 432797.0, 432952.0, 433361.8331908352, 61273.693631531554, 61936.76126477445, 62002.0, 62140.0, 62147.0, 64603.67698161479, 65997.34002659912, 66020.0, 66117.00824487637, 66200.67598648, 16465.753013704805, 16669.583260418585, 16676.416325428552, 16700.0, 16715.498535043967, 11686.006689431324, 11926.224795388272, 12884.80672789909, 12963.546275880299, 12994.090413671142, 12577.371131443391, 14567.635809104857, 17006.48980530586, 17219.65560688779, 17806.55483612894, 4996.850094497171, 6862.725490980405, 6878.621675807779, 6890.483213758988, 6938.83057122447, 868.6351732272461, 878.2271600991087, 888.9333300002526, 904.7692838326185, 915.6291701860757, 30054.0, 30158.095257142322, 30338.02718403919, 30475.93334233291, 30875.536866947015, 1046.1055797293357, 1050.9842352364722, 1093.371311495893, 1107.9224454288124, 1202.6271855724578, 13480.0, 15206.16366099875, 15547.533573992798, 15657.686846263012, 15801.130937798302, 523461.0, 528300.0, 528525.0, 529220.0, 529799.0, 59965.70017149974, 60123.09815352773, 60246.39753602495, 60481.39518604846, 60720.696396518615, 1442.5528086293282, 1442.581651321105, 1462.8829693624484, 1465.0477189826697, 1468.6328417895527, 28471.28821779389, 29244.853775731837, 29814.70185298206, 30391.240218994702, 30392.240193995327, 50624.49375506198, 51006.48993510017, 51150.0, 51194.48805512046, 51198.99999999851, 489525.0, 490497.0, 491096.0, 491888.0, 491966.0, 40019.599804002755, 40380.59619403768, 41035.7948210257, 41245.0, 41334.37998430086, 46117.76941115273, 46972.530274696815, 47184.820379489414, 47758.522414775405, 47883.521164787904, 33049.33901322008, 38138.61861381351, 38357.424638629884, 38593.0, 39031.0, 37951.81024094862, 38905.99583132202, 39210.803945980086, 39559.81320560388, 39940.80177594677, 36601.63398365982, 37308.25383492369, 37988.81005595065, 38016.23967520579, 38514.8445546634, 32480.0, 33491.66508334885, 34228.657713422544, 34328.82835585806, 34557.65442345645, 24599.38501537476, 24696.876515617307, 24951.87524062368, 25182.7003713913, 25317.620235696846], "value": 20175.272495521534, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.98893033209015, 378.5608693915059, 380.5395471479511, 401.2877143071049, 427.06259759827174, 14873.553793386202, 15183.937124401282, 18450.723239151408, 20330.49173770653, 20518.0, 21275.680864787002, 21289.0, 21846.45383865404, 21863.0, 21950.012249448773, 5029.698218106916, 5686.658800471964, 5762.135679648065, 5765.538756899459, 5892.587518873681, 5411.242426060355, 5784.0, 5788.5658575606785, 5790.913136302937, 5802.274715660543, 4110.506739191302, 4321.286987647034, 6058.485028772538, 6329.05064240363, 6374.585651932633, 6223.471004964584, 6412.615243085406, 6417.294097649255, 6425.164728585254, 6463.612183268995, 5684.772609095672, 5685.829425117253, 5692.37383887772, 5697.116946873241, 5701.657900525982, 25855.482890342275, 26060.478790424084, 26093.608595871076, 26104.73895261042, 26381.868090659424, 2666.4533770576986, 2761.254461295439, 2764.8617569121666, 2766.7233276672373, 2767.8892844286206, 15290.770638440432, 15362.0, 15467.767983480144, 15628.296726647328, 15769.684606307925, 1730.7144321186988, 1776.8845025073329, 1778.439791465697, 1796.4341232511717, 1807.159670753093, 87252.0, 109997.90002099957, 113033.0, 113220.43389783081, 114676.85323146745, 11086.113110951104, 11269.0, 11337.716557085974, 11382.658520244406, 11486.827697584544, 14333.78499322511, 14376.928115359357, 14386.496472623408, 14397.78403323951, 14398.280085995868, 7070.858582828315, 8264.462809917337, 8397.202265784741, 8636.524991125423, 8663.696770612998, 7190.820229494305, 8526.40315177944, 8560.743177704679, 8751.387402881865, 8759.824803503894, 7010.964945175241, 7103.822404439827, 7118.394936430358, 7137.179224389158, 7141.214466408691, 1889.1970912362465, 1932.8692714761742, 1933.5359513716887, 1936.0997136331673, 1938.5832046110154, 378.3700139268143, 383.65854389593284, 385.7415531593839, 1016.5628779624832, 1085.8588383510094, 9213.493257870747, 11683.357415342238, 12008.339541325136, 12076.818847717292, 12090.455929483194, 351.2781234562947, 408.7363650445446, 419.79010494752623, 423.8474149306247, 425.1497005988024, 4506.662000349987, 5211.244369566468, 6091.116788065706, 6145.907811382833, 6287.276963149205, 621206.0, 627795.8610206919, 642798.0, 758054.0, 765524.0, 156117.4388256103, 158664.41335586726, 160822.0, 162713.18643406944, 164589.17705411397, 437.31560108430205, 457.2820671545641, 457.36654733194763, 460.05917897898877, 460.82718980382356, 10138.884722680647, 11077.169212308949, 11162.716287627027, 11578.247413918069, 11704.590339338083, 57731.4226857726, 59005.704971474865, 60185.0, 61622.69188654028, 61902.69048654728, 80701.59649201717, 83763.16236837553, 85140.0, 85990.0, 86902.0, 8172.42793004484, 8180.46826956246, 8183.468074575134, 8223.204110602424, 8319.750407487785, 12623.747525049632, 12650.746985060063, 12665.746685066431, 12838.29389383593, 13253.86746132565, 10970.890291097307, 11041.72395690082, 11143.375499167754, 11201.271917325348, 11286.943565282449, 11166.888331116585, 11293.604723834625, 11358.26171298863, 11467.4266286687, 11590.652280431601, 11313.981741643292, 11512.791156928402, 11593.362365069665, 11612.6516204514, 11782.469788859693, 8243.299319557906, 8323.292520135856, 8460.788480287796, 8553.059163491886, 8564.828703426021, 9411.576479058596, 10662.8400573993, 10765.677029689123, 11060.446977650925, 11225.775484490428], "value": 8980.50603391918, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.433026789285, 1442.8052212951247, 1454.4691187716483, 1458.5041086030753, 1470.5000299898034, 8098.2306680865295, 8509.659613615448, 8523.57382130894, 8541.402101852873, 8542.95728521358, 7455.403567714583, 7667.616619169047, 7671.23287671234, 8068.152843951389, 8307.08622051574, 2287.5196208796133, 2331.5103828196097, 2333.614953532665, 2338.649202619604, 2339.3917581428864, 2306.9769302307013, 2336.7195936487647, 2346.5424242272766, 2354.0819080558595, 2356.646503024543, 2303.9884800576056, 2319.3273950554317, 2341.028473183627, 2345.847519911209, 2350.095213342858, 2289.3132060381986, 2291.232437133554, 2315.9421014474688, 2318.9188378406675, 2320.385097949028, 2272.8295377846725, 2346.2257455039967, 2346.6949296591506, 2351.2946116165253, 2351.8471299365488, 8396.244338009608, 8454.323654107657, 8462.15378462155, 8475.194856488624, 8492.108328625467, 5019.3976722793495, 5169.586433085382, 5183.50756678115, 5185.0, 5200.0, 3249.2526718854797, 3391.2369716813764, 3602.621724718893, 3605.4952306677087, 3608.025833025095, 1193.8985186259179, 1220.9816852747215, 1242.2670624331597, 1244.9538998255669, 1260.3950103950065, 10861.511231994578, 10904.454777261106, 10959.945200273947, 10984.121270298358, 10989.285696429786, 4397.36238245459, 4625.930611040837, 4715.0805592909055, 4715.127701375257, 4716.575508204278, 9541.522923853918, 9570.138687518156, 9571.760705982406, 9578.13796758295, 9584.856227156599, 5252.395974462986, 5253.474652534716, 5255.658382205144, 5257.737113144404, 5265.473452654781, 3933.350997085506, 4180.853670121531, 4684.133435314409, 4690.226112691368, 4792.161371759928, 3209.261869769966, 3847.5382954045135, 3914.2954268231993, 3972.0268534208726, 3973.8410463581713, 1264.304632452166, 1272.4401263444056, 1281.1992504684572, 1285.0554842190982, 1291.7416516696699, 777.0791611939869, 845.7547311279783, 893.7006102955582, 905.8324210021167, 907.3920473282916, 5091.261767043832, 5423.267858839085, 5544.473275038865, 5607.579431542651, 5796.362400135981, 901.9052999435096, 915.0757734688013, 975.9853602195973, 1002.964896228643, 1017.211660962745, 3059.709327613873, 3452.1197094740683, 3529.170644898447, 3679.6688298053305, 3681.889543313705, 9750.512474376254, 10058.346207496636, 10101.494925253708, 10116.140128089048, 10140.0, 9971.501424928725, 9996.300258981946, 10013.0, 10125.291229613857, 10167.694969150938, 7787.610619469004, 7882.960585197037, 7965.362770978308, 7966.960165199137, 7976.680932762741, 4653.488116307271, 4737.407824021997, 5256.290400795997, 5319.494648008433, 5394.595405344537, 9000.774980625536, 9067.909320906707, 9205.815883682422, 9291.349605527548, 9304.16262536375, 9147.451152930846, 9254.213391861767, 9438.339316248072, 9555.331126821056, 9568.665096721581, 6235.345288744798, 6411.647359395091, 6445.323241059808, 6683.8997415039785, 6716.093327400934, 7714.1128770192145, 7972.521648701097, 7987.800304992422, 8047.476914000571, 8080.9191908080165, 6930.0, 7124.465665075244, 7149.857002860018, 7221.67502462401, 7244.4566657499845, 6813.795586132225, 6988.808347936864, 7026.8945965809535, 7042.22535521082, 7103.786886393416, 5292.788288468418, 6331.2085989251345, 6373.012183111625, 6382.106505089384, 6390.105385245976, 4853.611711063036, 4858.1012512685265, 4891.144049791201, 4929.926051109164, 4937.654364194472, 4299.376590394438, 4551.907542189917, 4787.42550893895, 4840.152973229741, 4992.0], "value": 4392.627255285601, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.5587937138891, 356.9875054373097, 360.812377563667, 372.9627037296269, 372.97762134271926, 4189.706720529564, 4570.794314255858, 4831.68594041387, 5196.688198708081, 5200.843974680761, 4880.170371036923, 4984.22744474607, 4995.375578052744, 5001.59987201024, 5022.974885125569, 3767.6420740029653, 4074.470318858544, 4086.7139300248996, 4089.652379547742, 4092.3247664135383, 3904.2777086238993, 4093.038136038029, 4102.179564087194, 4113.136241389312, 4118.0, 3280.967190328102, 3898.7660740355527, 3992.8837716010416, 4023.879283621496, 4045.965525855608, 3936.9803150984203, 4035.3543433050572, 4047.6357127858632, 4049.6152865477734, 4059.6143366380293, 3036.5900603418477, 3204.3337464518554, 3636.945445818315, 3652.2695460907926, 3659.505966694489, 4238.91522169558, 4253.29820579604, 4487.887802804923, 4630.865437967719, 5119.616028797818, 4090.018395585038, 4278.358246263055, 4370.606645401929, 4708.929366059512, 4722.709485899336, 4811.49479304675, 5452.836414907559, 5475.439499742594, 5489.917651235235, 5560.443955604448, 3620.6560376764164, 4019.1311040366077, 4024.879253622396, 4025.174839157995, 4032.185516517579, 4517.774111294455, 4867.539738078563, 4989.301497790312, 5529.861753456155, 5645.237892884449, 3442.294329662413, 4069.674426045909, 4090.5661131626634, 4103.384492326175, 4117.691173161965, 3653.7394598863348, 4151.712968979626, 4162.292410290258, 4173.83304667816, 4175.457190565207, 4491.169133710274, 4606.262997920384, 4644.9767751161025, 4717.457492388351, 4793.209120495149, 4837.588804951619, 5221.269022336875, 5406.83779486616, 5440.727963601883, 5464.23500709901, 1176.894079532829, 1201.5133870782347, 1328.946842126304, 1336.1027341175554, 1358.4634069542476, 745.2026331824895, 951.8239125761756, 953.6280850468323, 965.6282331302499, 969.2294625772528, 4418.293073108352, 4459.420275364182, 4464.709793863389, 4479.664025198123, 4726.605651332865, 4918.401519506175, 5099.59203263738, 5236.450172731885, 5240.502152295526, 5252.369715634072, 3810.942835857464, 4719.457262414798, 4724.740139292303, 4732.02993386355, 4867.58625516835, 2290.473191166041, 2388.3312672451743, 2490.306591517749, 2581.0, 2730.2662809116355, 4501.527339629357, 4802.063597598435, 4904.185451383011, 5212.166053431432, 5408.702521361363, 4772.880677983078, 5169.327987361619, 5384.799856112239, 5386.757595908193, 5407.864803379868, 4915.0, 5028.1144570785955, 5176.903354141578, 5343.866403339947, 5441.401445840955, 4640.767961601974, 5266.8419947401635, 5296.947030529645, 5329.760160792696, 5333.546648534918, 4679.823881894935, 4847.321375007431, 4861.878453038561, 4914.434839993303, 5157.802162659175, 4737.8341758038305, 4791.904161916673, 5444.080262211201, 5449.501387118574, 5460.096031337613, 3584.426491761306, 3801.9239615208094, 3808.295465338921, 3822.4075268333454, 3824.2733880562605, 4403.8018289176425, 4837.588804951478, 5235.738213089407, 5240.764165612481, 5279.445658205833, 4176.832926682899, 4211.94633890427, 5074.340335756328, 5079.568236699922, 5116.846494605168, 4730.455997560324, 5084.186530155157, 5126.4364368867855, 5144.511271429208, 5156.639035267495, 4581.67131531852, 4939.876503087452, 4957.429895561912, 4964.578010868972, 5013.420772456664, 4207.6423504002505, 4714.693544919569, 4840.419149702058, 4919.483454237254, 5006.774695138654, 4133.669306455537, 4414.801333940045, 4966.701997880139, 4984.106039704889, 5028.673136246132], "value": 3891.3211316253714, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.5108495255982, 700.7792545348215, 734.8126227811907, 799.7840583042579, 808.2402541610884, 14475.782863257047, 15524.611884702888, 15531.145786981726, 15560.53318400447, 15565.766513502307, 14025.088369255991, 14079.57761267161, 14362.425502979868, 14406.207658578774, 14607.342669579868, 820.0774129104757, 854.4232642966005, 855.7432770168956, 856.0754385263931, 856.0882659967147, 843.527624530262, 844.0377969115214, 846.0101681033206, 846.3018010141627, 847.690592933581, 711.5766119159092, 737.5353527277834, 740.1894925057054, 741.9035525381693, 905.2983937448497, 905.8143080668447, 906.8775715278485, 907.3557773980482, 907.9001309855911, 907.9228265597433, 673.3535805626605, 673.4040374268808, 674.4739103499278, 674.5750177388214, 675.0481820632884, 12033.338166400845, 12491.0, 14553.563393098224, 15088.924555377263, 15297.770533442008, 14335.42658293667, 14518.491852785102, 14521.273936303249, 14523.927380363137, 14568.781468277984, 10861.619843305447, 10942.617008404668, 11088.390138542378, 11660.883391166064, 12000.759984800343, 3702.129999450127, 3704.74066815323, 3717.9628203718157, 3749.3063783200196, 3869.303525365433, 101196.9880301195, 108940.45529772379, 110650.0, 110829.44585277022, 112762.43618781936, 10031.197504199647, 10872.510737016853, 10946.781064378667, 11193.776124477465, 11360.659180224606, 22529.549409011728, 22676.88661556682, 23009.769902300763, 23018.539629207324, 23023.19418820333, 6997.160340759141, 7449.88825167623, 7888.0, 7922.207779222147, 8098.878516822252, 4199.685023623179, 4346.1090476452255, 4350.1734670412525, 4493.258612328995, 4523.705959112647, 3586.8923932282073, 3627.546556680415, 3649.708023358125, 3693.9261214776093, 3701.4632878232505, 672.67711498481, 672.6838385958591, 679.0222080204489, 679.1374953808636, 683.702589373624, 555.9805406810742, 624.5472032776291, 659.3768888400512, 662.5627086123231, 666.4901350466897, 8749.387542872066, 9515.619375225051, 9591.328606997582, 10048.79902401948, 10224.335418197794, 505.7597641120512, 512.50799232737, 541.9024575576356, 625.1872565664618, 670.8911637877527, 4535.0, 4948.925766113512, 4961.6030717543235, 4970.527799859007, 4975.278584605212, 77268.0, 94932.57601135988, 96486.0, 96509.0, 96967.51516242373, 83490.0, 84556.0, 85061.57469212615, 87887.1211287879, 88908.0, 73855.0, 75357.62321188359, 75843.0, 76046.85929711058, 77815.83276250861, 7895.0, 9320.627174912928, 9364.391314564531, 9432.386894851812, 9498.572564234488, 36347.54609815578, 40733.0, 43937.56062439334, 48108.0, 49904.75238119076, 48774.756126219145, 65044.0, 65091.67454162699, 66433.66783166054, 67540.6622966882, 11476.827847582126, 11513.769724605294, 11661.883381166079, 11730.648080557597, 11775.76448471043, 11988.580399685969, 12564.0, 12576.811347829973, 12633.052521061141, 12756.107072504836, 11330.546778128783, 11679.0, 11794.882051179378, 11894.226875253082, 12012.039036877204, 10012.599496020077, 11133.0, 11869.109816763605, 11988.76022479563, 12280.263184208976, 11023.61417350389, 11825.645230643095, 12189.0, 12190.08574356909, 12318.137730358789, 9233.538323083685, 9460.432374057578, 9765.609375624896, 9772.413655180711, 9905.405675659484, 6145.877082458415, 8372.581370931308, 9475.810483790423, 9541.761455963657, 9541.809163816824], "value": 7134.000638206327, "unit": "score"}], "name": "dromaeo_css", "value": 7028.229826406234, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 113.0, 114.0, 114.0, 117.0, 161.0, 170.0, 113.0, 115.0], "value": 124.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 127.0, 137.0, 187.0, 115.0, 109.0, 110.0, 112.0, 130.0, 110.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 183.0, 186.0, 185.0, 186.0, 185.0, 185.0, 184.0, 182.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 59.0, 92.0, 59.0, 58.0, 58.0, 58.0, 73.0, 61.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 86.0, 70.0, 69.0, 69.0, 83.0, 70.0, 70.0, 82.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 88.0, 84.0, 89.0, 86.0, 88.0, 87.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 93.0, 93.0, 94.0, 93.0, 93.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 95.0, 88.0, 85.0, 85.0, 87.0, 87.0, 87.0], "value": 87.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 84.0, 77.0, 72.0, 70.0, 72.0, 71.0, 71.0, 71.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 87.0, 83.0, 84.0, 82.0, 86.0, 85.0, 89.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 140.0, 183.0, 157.0, 146.0, 152.0, 154.0, 139.0, 179.0, 138.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 168.0, 167.0, 214.0, 224.0, 167.0, 165.0, 170.0, 167.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 65.0, 65.0, 65.0, 68.0, 78.0, 85.0, 83.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1459.2, "alertThreshold": 2.0}]} 09:08:28 INFO - Return code: 0 09:08:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:08:28 ERROR - # TBPL SUCCESS # 09:08:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:08:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:08:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:08:28 INFO - 2017-02-16 09:08:28.490 screenresolution[2191:72891] starting screenresolution argv=screenresolution get 09:08:28 INFO - 2017-02-16 09:08:28.492 screenresolution[2191:72891] Display 0: 1600x1200x32@60 09:08:28 INFO - 2017-02-16 09:08:28.498 screenresolution[2192:72894] starting screenresolution argv=screenresolution list 09:08:28 INFO - Available Modes on Display 0 09:08:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:08:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:08:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:08:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:08:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:08:28 INFO - Intel Iris: 09:08:28 INFO - Chipset Model: Intel Iris 09:08:28 INFO - Type: GPU 09:08:28 INFO - Bus: Built-In 09:08:28 INFO - VRAM (Dynamic, Max): 1536 MB 09:08:28 INFO - Vendor: Intel (0x8086) 09:08:28 INFO - Device ID: 0x0a2e 09:08:28 INFO - Revision ID: 0x0009 09:08:28 INFO - Displays: 09:08:28 INFO - Display: 09:08:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:08:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:08:28 INFO - Display Serial Number: 1600x1200 60 09:08:28 INFO - Main Display: Yes 09:08:28 INFO - Mirror: Off 09:08:28 INFO - Online: Yes 09:08:28 INFO - Rotation: Supported 09:08:28 INFO - Return code: 0 09:08:28 INFO - Running post-action listener: _resource_record_post_action 09:08:28 INFO - [mozharness: 2017-02-16 17:08:28.741022Z] Finished run-tests step (success) 09:08:28 INFO - Running post-run listener: _resource_record_post_run 09:08:28 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 4096; Write bytes: 506385920; Read time: 0; Write time: 1676 09:08:28 INFO - TinderboxPrint: CPU usage
53.7% 09:08:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 0 09:08:28 INFO - TinderboxPrint: I/O write bytes / time
506,385,920 / 1,676 09:08:28 INFO - TinderboxPrint: CPU idle
2,223.5 (46.3%) 09:08:28 INFO - TinderboxPrint: CPU system
960.8 (20.0%) 09:08:28 INFO - TinderboxPrint: CPU user
1,617.4 (33.7%) 09:08:28 INFO - TinderboxPrint: Swap in / out
207,224,832 / 0 09:08:28 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205289984; Write bytes: 201303552; Read time: 15709; Write time: 487 09:08:28 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 4096; Write bytes: 294113280; Read time: 0; Write time: 1151 09:08:29 INFO - Running post-run listener: _upload_blobber_files 09:08:29 INFO - Blob upload gear active. 09:08:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:29 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 09:08:29 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'] 09:08:29 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 09:08:29 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:08:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:08:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:31 INFO - (blobuploader) - INFO - Done attempting. 09:08:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:08:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:32 INFO - (blobuploader) - INFO - Done attempting. 09:08:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:08:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:08:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:33 INFO - (blobuploader) - INFO - Done attempting. 09:08:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:08:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:08:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:35 INFO - (blobuploader) - INFO - Done attempting. 09:08:35 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:35 INFO - Return code: 0 09:08:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c10207578b535844c9a3664f51a7ede39812a0ee81f760c41cb889a55aeb7583d4f6adcb1fc428dae353f138b3bb34e6de0cf4488b4aae5e1969d717e1efa842", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50f45350a2290642968765941d058c20c787e0927e07b3785f4b3e5ee5292475a27cbecdfc2766ecabca0a8070acfb7d43a160f63e700137e23c58ef7335e601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b0c75214596ea09dc2b45efe15a72f3935f2798fa997aabd01d902f7984873c64c7e76dd58168bce67fe03e24c823c5a885437d0999600a571a5b4bf5368c0e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51b6de2e593638723cc80b42b99810d37c23d23f20b47951542feff755bacea038603c7d1a44821f6ed9eab937bb14adc1f956df5e75eb8d89d5962fff69b48d"} 09:08:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:35 INFO - Contents: 09:08:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c10207578b535844c9a3664f51a7ede39812a0ee81f760c41cb889a55aeb7583d4f6adcb1fc428dae353f138b3bb34e6de0cf4488b4aae5e1969d717e1efa842", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50f45350a2290642968765941d058c20c787e0927e07b3785f4b3e5ee5292475a27cbecdfc2766ecabca0a8070acfb7d43a160f63e700137e23c58ef7335e601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b0c75214596ea09dc2b45efe15a72f3935f2798fa997aabd01d902f7984873c64c7e76dd58168bce67fe03e24c823c5a885437d0999600a571a5b4bf5368c0e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51b6de2e593638723cc80b42b99810d37c23d23f20b47951542feff755bacea038603c7d1a44821f6ed9eab937bb14adc1f956df5e75eb8d89d5962fff69b48d"} 09:08:35 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:35 INFO - Copying logs to upload dir... 09:08:35 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.421510 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-16 09:08:35.346263) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 09:08:35.349546) ========= 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.br1E5p936P/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.KrEnzAbDWr/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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/c10207578b535844c9a3664f51a7ede39812a0ee81f760c41cb889a55aeb7583d4f6adcb1fc428dae353f138b3bb34e6de0cf4488b4aae5e1969d717e1efa842", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50f45350a2290642968765941d058c20c787e0927e07b3785f4b3e5ee5292475a27cbecdfc2766ecabca0a8070acfb7d43a160f63e700137e23c58ef7335e601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b0c75214596ea09dc2b45efe15a72f3935f2798fa997aabd01d902f7984873c64c7e76dd58168bce67fe03e24c823c5a885437d0999600a571a5b4bf5368c0e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51b6de2e593638723cc80b42b99810d37c23d23f20b47951542feff755bacea038603c7d1a44821f6ed9eab937bb14adc1f956df5e75eb8d89d5962fff69b48d"} build_url:https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011038 build_url: 'https://queue.taskcluster.net/v1/task/Xl6B_SNETPajuG-PAYPpAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c10207578b535844c9a3664f51a7ede39812a0ee81f760c41cb889a55aeb7583d4f6adcb1fc428dae353f138b3bb34e6de0cf4488b4aae5e1969d717e1efa842", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50f45350a2290642968765941d058c20c787e0927e07b3785f4b3e5ee5292475a27cbecdfc2766ecabca0a8070acfb7d43a160f63e700137e23c58ef7335e601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b0c75214596ea09dc2b45efe15a72f3935f2798fa997aabd01d902f7984873c64c7e76dd58168bce67fe03e24c823c5a885437d0999600a571a5b4bf5368c0e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51b6de2e593638723cc80b42b99810d37c23d23f20b47951542feff755bacea038603c7d1a44821f6ed9eab937bb14adc1f956df5e75eb8d89d5962fff69b48d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 09:08:35.383350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 09:08:35.383668) ========= 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.br1E5p936P/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.KrEnzAbDWr/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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.005442 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 09:08:35.432919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 09:08:35.433465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 09:08:35.434014) ========= ========= Total master_lag: 0.18 =========