builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0034 starttime: 1485361168.71 results: success (0) buildid: 20170125065748 builduid: fba08dcc06f847829057e0e1e2e62b6f revision: 47e238a0c9e34e04d7c93cb3367e20c987f9af0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:28.705995) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:28.706930) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:28.707579) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:28.736870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:28.737516) ========= 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.cfmHsolFPV/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.VEOa1yKokA/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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-01-25 08:19:28-- 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% 166M=0s 2017-01-25 08:19:29 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.812823 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:29.634516) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:29.634913) ========= 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.cfmHsolFPV/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.VEOa1yKokA/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.026303 ========= master_lag: 0.82 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:30.484311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 08:19:30.485168) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 47e238a0c9e34e04d7c93cb3367e20c987f9af0d --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 47e238a0c9e34e04d7c93cb3367e20c987f9af0d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cfmHsolFPV/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.VEOa1yKokA/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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-01-25 08:19:30,595 truncating revision to first 12 chars 2017-01-25 08:19:30,595 Setting DEBUG logging. 2017-01-25 08:19:30,595 attempt 1/10 2017-01-25 08:19:30,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/47e238a0c9e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 08:19:31,611 unpacking tar archive at: mozilla-aurora-47e238a0c9e3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.289450 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 08:19:31.895666) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:31.896039) ========= script_repo_revision: 47e238a0c9e34e04d7c93cb3367e20c987f9af0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:31.896649) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:31.896982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 08:19:31.918412) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-25 08:19:31.919126) ========= /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.cfmHsolFPV/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.VEOa1yKokA/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:19:32 INFO - MultiFileLogger online at 20170125 08:19:32 in /builds/slave/test 08:19: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:19:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:19:32 INFO - {'append_to_log': False, 08:19:32 INFO - 'base_work_dir': '/builds/slave/test', 08:19:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:19:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:19:32 INFO - 'branch': 'Mozilla-Aurora', 08:19:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:19:32 INFO - 'config_files': ('talos/mac_config.py',), 08:19:32 INFO - 'default_actions': ('clobber', 08:19:32 INFO - 'read-buildbot-config', 08:19:32 INFO - 'download-and-extract', 08:19:32 INFO - 'populate-webroot', 08:19:32 INFO - 'create-virtualenv', 08:19:32 INFO - 'install', 08:19:32 INFO - 'run-tests'), 08:19:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:19:32 INFO - 'download_minidump_stackwalk': True, 08:19:32 INFO - 'download_symbols': 'ondemand', 08:19:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:19:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:19:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:19:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:19:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:19:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:19:32 INFO - 'installer_path': 'installer.exe', 08:19:32 INFO - 'log_level': 'info', 08:19:32 INFO - 'log_name': 'talos', 08:19:32 INFO - 'log_to_console': True, 08:19:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:19:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:19:32 INFO - 'opt_config_files': (), 08:19:32 INFO - 'pip_index': False, 08:19:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:19:32 INFO - 'cmd': ('bash', 08:19:32 INFO - '-c', 08:19:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:19:32 INFO - 'enabled': True, 08:19:32 INFO - 'halt_on_failure': False, 08:19:32 INFO - 'name': 'check_screen_resolution'},), 08:19:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:19:32 INFO - 'cmd': ('bash', 08:19:32 INFO - '-c', 08:19:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:19:32 INFO - 'enabled': True, 08:19:32 INFO - 'halt_on_failure': False, 08:19:32 INFO - 'name': 'check_screen_resolution'},), 08:19:32 INFO - 'run_cmd_checks_enabled': True, 08:19:32 INFO - 'sps_profile': False, 08:19:32 INFO - 'sps_profile_interval': 0, 08:19:32 INFO - 'suite': 'dromaeojs', 08:19:32 INFO - 'system_bits': '32', 08:19:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:19:32 INFO - 'title': 't-yosemite-r7-0034', 08:19:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:19:32 INFO - 'use_talos_json': True, 08:19:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:19:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:19:32 INFO - 'work_dir': 'build'} 08:19:32 INFO - [mozharness: 2017-01-25 16:19:32.150595Z] Running clobber step. 08:19:32 INFO - Running pre-action listener: _resource_record_pre_action 08:19:32 INFO - Running main action method: clobber 08:19:32 INFO - rmtree: /builds/slave/test/build 08:19:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:19:34 INFO - Running post-action listener: _resource_record_post_action 08:19:34 INFO - [mozharness: 2017-01-25 16:19:34.727987Z] Finished clobber step (success) 08:19:34 INFO - [mozharness: 2017-01-25 16:19:34.728244Z] Running read-buildbot-config step. 08:19:34 INFO - Running pre-action listener: _resource_record_pre_action 08:19:34 INFO - Running main action method: read_buildbot_config 08:19:34 INFO - Using buildbot properties: 08:19:34 INFO - { 08:19:34 INFO - "project": "", 08:19:34 INFO - "product": "firefox", 08:19:34 INFO - "script_repo_revision": "production", 08:19:34 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:19:34 INFO - "repository": "", 08:19:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:19:34 INFO - "buildid": "20170125065748", 08:19:34 INFO - "pgo_build": "False", 08:19:34 INFO - "basedir": "/builds/slave/test", 08:19:34 INFO - "buildnumber": 37, 08:19:34 INFO - "slavename": "t-yosemite-r7-0034", 08:19:34 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:19:34 INFO - "platform": "yosemite_r7", 08:19:34 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:19:34 INFO - "branch": "mozilla-aurora", 08:19:34 INFO - "repo_path": "releases/mozilla-aurora", 08:19:34 INFO - "revision": "47e238a0c9e34e04d7c93cb3367e20c987f9af0d", 08:19:34 INFO - "stage_platform": "macosx64", 08:19:34 INFO - "builduid": "fba08dcc06f847829057e0e1e2e62b6f", 08:19:34 INFO - "slavebuilddir": "test" 08:19:34 INFO - } 08:19:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:19:34 INFO - Running post-action listener: _resource_record_post_action 08:19:34 INFO - [mozharness: 2017-01-25 16:19:34.734266Z] Finished read-buildbot-config step (success) 08:19:34 INFO - [mozharness: 2017-01-25 16:19:34.734508Z] Running download-and-extract step. 08:19:34 INFO - Running pre-action listener: _resource_record_pre_action 08:19:34 INFO - Running main action method: download_and_extract 08:19:34 INFO - mkdir: /builds/slave/test/build/tests 08:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:34 INFO - trying https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:19:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/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:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/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:19:35 INFO - Downloaded 1199 bytes. 08:19:35 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:19:35 INFO - Using the following test package requirements: 08:19:35 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:19:35 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:19:35 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:19:35 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:19:35 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:19:35 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:19:35 INFO - u'jsshell-mac.zip'], 08:19:35 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:19:35 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:19:35 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:19:35 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:19:35 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:19:35 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:19:35 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:19:35 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:19:35 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:19:35 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:19:35 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:19:35 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:19:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:19:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:19:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:19:36 INFO - Expected file size: 16349682 08:19:36 INFO - Obtained file size: 16349682 08:19:44 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:19:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:19:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:19:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:19:44 INFO - Expected file size: 16349682 08:19:44 INFO - Obtained file size: 16349682 08:19:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:19:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:19:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:19:52 INFO - Expected file size: 14403485 08:19:52 INFO - Obtained file size: 14403485 08:19: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:19:52 INFO - trying https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:19:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/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:19:54 INFO - Downloaded 73890418 bytes. 08:19:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:19:54 INFO - mkdir: /builds/slave/test/properties 08:19:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:19:54 INFO - Writing to file /builds/slave/test/properties/build_url 08:19:54 INFO - Contents: 08:19:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:19:55 INFO - Running post-action listener: _resource_record_post_action 08:19:55 INFO - Running post-action listener: set_extra_try_arguments 08:19:55 INFO - [mozharness: 2017-01-25 16:19:55.550680Z] Finished download-and-extract step (success) 08:19:55 INFO - [mozharness: 2017-01-25 16:19:55.550812Z] Running populate-webroot step. 08:19:55 INFO - Running pre-action listener: _resource_record_pre_action 08:19:55 INFO - Running main action method: populate_webroot 08:19:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:19:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:19:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:19:55 INFO - '--tppagecycles', 08:19:55 INFO - '7'], 08:19:55 INFO - 'tests': ['tsvgm']}}, 08:19:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:19:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:19:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:19:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:19:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:19:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:19:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:19:55 INFO - 'talos_options': ['--disable-e10s'], 08:19:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:19:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:19:55 INFO - 'talos_options': ['--disable-e10s'], 08:19:55 INFO - 'tests': ['damp', 'tps']}, 08:19:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:19:55 INFO - 'tests': ['damp', 'tps']}, 08:19:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:19:55 INFO - 'tests': ['dromaeo_dom']}, 08:19:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:19:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:19:55 INFO - 'tests': ['basic_compositor_video']}, 08:19:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:19:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:19:55 INFO - 'tests': ['a11yr', 08:19:55 INFO - 'ts_paint', 08:19:55 INFO - 'tpaint', 08:19:55 INFO - 'sessionrestore', 08:19:55 INFO - 'sessionrestore_no_auto_restore', 08:19:55 INFO - 'tabpaint']}, 08:19:55 INFO - 'other-e10s': {'tests': ['a11yr', 08:19:55 INFO - 'ts_paint', 08:19:55 INFO - 'tpaint', 08:19:55 INFO - 'sessionrestore', 08:19:55 INFO - 'sessionrestore_no_auto_restore', 08:19:55 INFO - 'tabpaint']}, 08:19:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:19:55 INFO - 'ts_paint', 08:19:55 INFO - 'tpaint', 08:19:55 INFO - 'sessionrestore', 08:19:55 INFO - 'sessionrestore_no_auto_restore', 08:19:55 INFO - 'tabpaint']}, 08:19:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:19:55 INFO - 'ts_paint', 08:19:55 INFO - 'tpaint', 08:19:55 INFO - 'sessionrestore', 08:19:55 INFO - 'sessionrestore_no_auto_restore', 08:19:55 INFO - 'tabpaint']}, 08:19:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:19:55 INFO - 'tests': ['a11yr', 08:19:55 INFO - 'ts_paint', 08:19:55 INFO - 'tpaint', 08:19:55 INFO - 'sessionrestore', 08:19:55 INFO - 'sessionrestore_no_auto_restore', 08:19:55 INFO - 'tabpaint']}, 08:19:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:19:55 INFO - 'tests': ['a11yr', 08:19:55 INFO - 'ts_paint', 08:19:55 INFO - 'tpaint', 08:19:55 INFO - 'sessionrestore', 08:19:55 INFO - 'sessionrestore_no_auto_restore', 08:19:55 INFO - 'tabpaint']}, 08:19:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:19:55 INFO - 'tests': ['tsvgx', 08:19:55 INFO - 'tsvgr_opacity', 08:19:55 INFO - 'tart', 08:19:55 INFO - 'tscrollx', 08:19:55 INFO - 'cart', 08:19:55 INFO - 'tsvg_static']}, 08:19:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:19:55 INFO - 'tsvgr_opacity', 08:19:55 INFO - 'tart', 08:19:55 INFO - 'tscrollx', 08:19:55 INFO - 'cart', 08:19:55 INFO - 'tsvg_static']}, 08:19:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:19:55 INFO - 'talos_options': ['--disable-e10s'], 08:19:55 INFO - 'tests': ['tp5o']}, 08:19:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:19:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:19:55 INFO - 'talos_options': ['--disable-e10s', 08:19:55 INFO - '--xperf_path', 08:19:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:55 INFO - 'tests': ['tp5n']}, 08:19:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:19:55 INFO - 'talos_options': ['--xperf_path', 08:19:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:55 INFO - 'tests': ['tp5n']}}, 08:19:55 INFO - 'talos.zip': {'path': '', 08:19:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:19:55 INFO - Running post-action listener: _resource_record_post_action 08:19:55 INFO - [mozharness: 2017-01-25 16:19:55.569531Z] Finished populate-webroot step (success) 08:19:55 INFO - [mozharness: 2017-01-25 16:19:55.569675Z] Running create-virtualenv step. 08:19:55 INFO - Running pre-action listener: _resource_record_pre_action 08:19:55 INFO - Running main action method: create_virtualenv 08:19:55 INFO - Creating virtualenv /builds/slave/test/build/venv 08:19: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:19:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:19:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:19:55 INFO - Using real prefix '/tools/python27' 08:19:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:19:56 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:59 INFO - Installing pip.................done. 08:19:59 INFO - Return code: 0 08:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:19:59 INFO - Reading from file tmpfile_stdout 08:19:59 INFO - Output received: 08:19: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:19:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:19: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:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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 0x104c7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb2cd5430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5ad30>, '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 0x104981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a4fbe8>, '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.cfmHsolFPV/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.VEOa1yKokA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:19: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:19: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:19:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfmHsolFPV/Render', 08:19:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:59 INFO - 'HOME': '/Users/cltbld', 08:19:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:59 INFO - 'LOGNAME': 'cltbld', 08:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:59 INFO - 'MOZ_NO_REMOTE': '1', 08:19:59 INFO - 'NO_EM_RESTART': '1', 08:19:59 INFO - 'PAGER': '/bin/cat', 08:19:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:59 INFO - 'PWD': '/builds/slave/test', 08:19:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:59 INFO - 'SHELL': '/bin/bash', 08:19:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VEOa1yKokA/Listeners', 08:19:59 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 08:19:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:59 INFO - 'USER': 'cltbld', 08:19:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:59 INFO - 'XPC_FLAGS': '0x0', 08:19:59 INFO - 'XPC_SERVICE_NAME': '0', 08:19:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:00 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:20:00 INFO - Cleaning up... 08:20:00 INFO - Return code: 0 08:20:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104c7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb2cd5430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5ad30>, '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 0x104981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a4fbe8>, '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.cfmHsolFPV/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.VEOa1yKokA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:20:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfmHsolFPV/Render', 08:20:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:00 INFO - 'HOME': '/Users/cltbld', 08:20:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:00 INFO - 'LOGNAME': 'cltbld', 08:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:00 INFO - 'MOZ_NO_REMOTE': '1', 08:20:00 INFO - 'NO_EM_RESTART': '1', 08:20:00 INFO - 'PAGER': '/bin/cat', 08:20:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:00 INFO - 'PWD': '/builds/slave/test', 08:20:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:00 INFO - 'SHELL': '/bin/bash', 08:20:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VEOa1yKokA/Listeners', 08:20:00 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 08:20:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:00 INFO - 'USER': 'cltbld', 08:20:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:00 INFO - 'XPC_FLAGS': '0x0', 08:20:00 INFO - 'XPC_SERVICE_NAME': '0', 08:20:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:00 INFO - Downloading/unpacking psutil>=3.1.1 08:20:00 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:20:00 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:20:00 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:20:00 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:20:00 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:20:00 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:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:20:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:04 INFO - Installing collected packages: psutil 08:20:04 INFO - Running setup.py install for psutil 08:20:04 INFO - building 'psutil._psutil_osx' extension 08:20:04 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:20:04 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:20:04 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:20:05 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:20:05 INFO - building 'psutil._psutil_posix' extension 08:20:05 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:20:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:20:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:20:05 INFO - ^ 08:20:05 INFO - 1 warning generated. 08:20:05 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:20:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:05 INFO - Successfully installed psutil 08:20:05 INFO - Cleaning up... 08:20:05 INFO - Return code: 0 08:20:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:20:05 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:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:05 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:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:05 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 0x104c7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb2cd5430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5ad30>, '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 0x104981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a4fbe8>, '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.cfmHsolFPV/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.VEOa1yKokA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:20:05 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:20:05 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:20:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfmHsolFPV/Render', 08:20:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:05 INFO - 'HOME': '/Users/cltbld', 08:20:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:05 INFO - 'LOGNAME': 'cltbld', 08:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:05 INFO - 'MOZ_NO_REMOTE': '1', 08:20:05 INFO - 'NO_EM_RESTART': '1', 08:20:05 INFO - 'PAGER': '/bin/cat', 08:20:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:05 INFO - 'PWD': '/builds/slave/test', 08:20:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:05 INFO - 'SHELL': '/bin/bash', 08:20:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VEOa1yKokA/Listeners', 08:20:05 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 08:20:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:05 INFO - 'USER': 'cltbld', 08:20:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:05 INFO - 'XPC_FLAGS': '0x0', 08:20:05 INFO - 'XPC_SERVICE_NAME': '0', 08:20:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:20:05 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:20:05 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:20:05 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:20:05 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:20:05 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:20:05 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:20:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:20:08 INFO - Installing collected packages: mozsystemmonitor 08:20:08 INFO - Running setup.py install for mozsystemmonitor 08:20:08 INFO - Successfully installed mozsystemmonitor 08:20:08 INFO - Cleaning up... 08:20:08 INFO - Return code: 0 08:20:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:20:08 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:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:08 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:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:08 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 0x104c7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb2cd5430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5ad30>, '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 0x104981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a4fbe8>, '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.cfmHsolFPV/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.VEOa1yKokA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:20:08 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:20:08 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:20:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfmHsolFPV/Render', 08:20:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:08 INFO - 'HOME': '/Users/cltbld', 08:20:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:08 INFO - 'LOGNAME': 'cltbld', 08:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:08 INFO - 'MOZ_NO_REMOTE': '1', 08:20:08 INFO - 'NO_EM_RESTART': '1', 08:20:08 INFO - 'PAGER': '/bin/cat', 08:20:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:08 INFO - 'PWD': '/builds/slave/test', 08:20:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:08 INFO - 'SHELL': '/bin/bash', 08:20:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VEOa1yKokA/Listeners', 08:20:08 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 08:20:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:08 INFO - 'USER': 'cltbld', 08:20:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:08 INFO - 'XPC_FLAGS': '0x0', 08:20:08 INFO - 'XPC_SERVICE_NAME': '0', 08:20:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:09 INFO - Downloading/unpacking jsonschema==2.5.1 08:20:09 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:20:09 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:20:09 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:20:09 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:20:09 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:20:09 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:20:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:20:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:20: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:20: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:20: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:20: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:20: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:20: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:20:12 INFO - Downloading functools32-3.2.3-2.tar.gz 08:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:20:12 INFO - warning: no files found matching '*.txt' 08:20:12 INFO - no previously-included directories found matching 'build' 08:20:12 INFO - no previously-included directories found matching 'dist' 08:20:12 INFO - no previously-included directories found matching '.git*' 08:20:12 INFO - Installing collected packages: jsonschema, functools32 08:20:12 INFO - Running setup.py install for functools32 08:20:12 INFO - warning: no files found matching '*.txt' 08:20:12 INFO - no previously-included directories found matching 'build' 08:20:12 INFO - no previously-included directories found matching 'dist' 08:20:12 INFO - no previously-included directories found matching '.git*' 08:20:12 INFO - Successfully installed jsonschema functools32 08:20:12 INFO - Cleaning up... 08:20:12 INFO - Return code: 0 08:20:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:12 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 0x104c7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb2cd5430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5ad30>, '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 0x104981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a4fbe8>, '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.cfmHsolFPV/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.VEOa1yKokA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:20:12 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:20:12 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:20:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfmHsolFPV/Render', 08:20:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:12 INFO - 'HOME': '/Users/cltbld', 08:20:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:12 INFO - 'LOGNAME': 'cltbld', 08:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:12 INFO - 'MOZ_NO_REMOTE': '1', 08:20:12 INFO - 'NO_EM_RESTART': '1', 08:20:12 INFO - 'PAGER': '/bin/cat', 08:20:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:12 INFO - 'PWD': '/builds/slave/test', 08:20:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:12 INFO - 'SHELL': '/bin/bash', 08:20:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VEOa1yKokA/Listeners', 08:20:12 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 08:20:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:12 INFO - 'USER': 'cltbld', 08:20:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:12 INFO - 'XPC_FLAGS': '0x0', 08:20:12 INFO - 'XPC_SERVICE_NAME': '0', 08:20:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:20:12 INFO - Cleaning up... 08:20:12 INFO - Return code: 0 08:20:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:12 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 0x104c7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb2cd5430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5ad30>, '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 0x104981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a4fbe8>, '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.cfmHsolFPV/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.VEOa1yKokA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:20:12 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:20:12 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:20:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfmHsolFPV/Render', 08:20:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:12 INFO - 'HOME': '/Users/cltbld', 08:20:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:12 INFO - 'LOGNAME': 'cltbld', 08:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:12 INFO - 'MOZ_NO_REMOTE': '1', 08:20:12 INFO - 'NO_EM_RESTART': '1', 08:20:12 INFO - 'PAGER': '/bin/cat', 08:20:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:12 INFO - 'PWD': '/builds/slave/test', 08:20:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:12 INFO - 'SHELL': '/bin/bash', 08:20:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VEOa1yKokA/Listeners', 08:20:12 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 08:20:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:12 INFO - 'USER': 'cltbld', 08:20:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:12 INFO - 'XPC_FLAGS': '0x0', 08:20:12 INFO - 'XPC_SERVICE_NAME': '0', 08:20:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:20:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:20:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:17 INFO - Downloading docopt-0.6.1.tar.gz 08:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:20:17 INFO - Installing collected packages: blobuploader, requests, docopt 08:20:17 INFO - Running setup.py install for blobuploader 08:20:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:20:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:20:17 INFO - Running setup.py install for requests 08:20:17 INFO - Running setup.py install for docopt 08:20:18 INFO - Successfully installed blobuploader requests docopt 08:20:18 INFO - Cleaning up... 08:20:18 INFO - Return code: 0 08:20:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:18 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:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:18 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:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:18 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 0x104c7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb2cd5430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5ad30>, '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 0x104981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a4fbe8>, '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.cfmHsolFPV/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.VEOa1yKokA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:20:18 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:20:18 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:20:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfmHsolFPV/Render', 08:20:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:18 INFO - 'HOME': '/Users/cltbld', 08:20:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:18 INFO - 'LOGNAME': 'cltbld', 08:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:18 INFO - 'MOZ_NO_REMOTE': '1', 08:20:18 INFO - 'NO_EM_RESTART': '1', 08:20:18 INFO - 'PAGER': '/bin/cat', 08:20:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:18 INFO - 'PWD': '/builds/slave/test', 08:20:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:18 INFO - 'SHELL': '/bin/bash', 08:20:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VEOa1yKokA/Listeners', 08:20:18 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 08:20:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:18 INFO - 'USER': 'cltbld', 08:20:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:18 INFO - 'XPC_FLAGS': '0x0', 08:20:18 INFO - 'XPC_SERVICE_NAME': '0', 08:20:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:18 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-sbv3Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:18 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-2_e5LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:18 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-h79GQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:18 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-7PYY3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:18 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-PRl_Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-B5jR7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-RbFEoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-qh3mhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-0ynqL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-kLNuOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-ALLbc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-zbvtM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-wpwnoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-lxiO9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-B0eh1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-bzLYwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-gvmEk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:20:20 INFO - Running setup.py install for manifestparser 08:20:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:20:20 INFO - Running setup.py install for mozcrash 08:20:20 INFO - Running setup.py install for mozdebug 08:20:20 INFO - Running setup.py install for mozdevice 08:20:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:20:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:20:20 INFO - Running setup.py install for mozfile 08:20:21 INFO - Running setup.py install for mozhttpd 08:20:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Running setup.py install for mozinfo 08:20:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Running setup.py install for mozInstall 08:20:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Running setup.py install for mozleak 08:20:21 INFO - Running setup.py install for mozlog 08:20:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Running setup.py install for moznetwork 08:20:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:20:22 INFO - Running setup.py install for mozprocess 08:20:22 INFO - Running setup.py install for mozprofile 08:20:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:20:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:20:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:20:22 INFO - Running setup.py install for mozrunner 08:20:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:20:22 INFO - Running setup.py install for mozscreenshot 08:20:22 INFO - Running setup.py install for moztest 08:20:22 INFO - Running setup.py install for mozversion 08:20:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:20:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:20:23 INFO - Cleaning up... 08:20:23 INFO - Return code: 0 08:20:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:23 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 0x104c7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb2cd5430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5ad30>, '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 0x104981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a4fbe8>, '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.cfmHsolFPV/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.VEOa1yKokA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:20:23 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:20:23 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:20:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfmHsolFPV/Render', 08:20:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:23 INFO - 'HOME': '/Users/cltbld', 08:20:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:23 INFO - 'LOGNAME': 'cltbld', 08:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:23 INFO - 'MOZ_NO_REMOTE': '1', 08:20:23 INFO - 'NO_EM_RESTART': '1', 08:20:23 INFO - 'PAGER': '/bin/cat', 08:20:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:23 INFO - 'PWD': '/builds/slave/test', 08:20:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:23 INFO - 'SHELL': '/bin/bash', 08:20:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VEOa1yKokA/Listeners', 08:20:23 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 08:20:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:23 INFO - 'USER': 'cltbld', 08:20:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:23 INFO - 'XPC_FLAGS': '0x0', 08:20:23 INFO - 'XPC_SERVICE_NAME': '0', 08:20:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:23 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-EDF7Z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:23 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Cq56wH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:23 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-p6DVNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:23 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-rFTh0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:23 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-SBGRyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:23 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-V4R8Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Im59qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Q5cvXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-yUejtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-aZEzYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-WmmeSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-vig24m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-IhVT1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-xNmV_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-F4iedJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:25 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:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:25 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Q2LsGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:25 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:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:25 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-1qjqLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:25 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:20:25 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:20:25 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:20:25 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:20:25 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:20:25 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:20:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:20:25 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:20:25 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:20:25 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:20:25 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:20:25 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:20:25 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:20:27 INFO - Downloading blessings-1.6.tar.gz 08:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:20:27 INFO - Installing collected packages: blessings 08:20:27 INFO - Running setup.py install for blessings 08:20:28 INFO - Successfully installed blessings 08:20:28 INFO - Cleaning up... 08:20:28 INFO - Return code: 0 08:20:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:20:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:20:28 INFO - Reading from file tmpfile_stdout 08:20:28 INFO - Current package versions: 08:20:28 INFO - blessings == 1.6 08:20:28 INFO - blobuploader == 1.2.4 08:20:28 INFO - docopt == 0.6.1 08:20:28 INFO - functools32 == 3.2.3-2 08:20:28 INFO - jsonschema == 2.5.1 08:20:28 INFO - manifestparser == 1.1 08:20:28 INFO - mozInstall == 1.12 08:20:28 INFO - mozcrash == 1.0 08:20:28 INFO - mozdebug == 0.1 08:20:28 INFO - mozdevice == 0.49 08:20:28 INFO - mozfile == 1.2 08:20:28 INFO - mozhttpd == 0.7 08:20:28 INFO - mozinfo == 0.9 08:20:28 INFO - mozleak == 0.1 08:20:28 INFO - mozlog == 3.4 08:20:28 INFO - moznetwork == 0.27 08:20:28 INFO - mozprocess == 0.24 08:20:28 INFO - mozprofile == 0.28 08:20:28 INFO - mozrunner == 6.13 08:20:28 INFO - mozscreenshot == 0.1 08:20:28 INFO - mozsystemmonitor == 0.3 08:20:28 INFO - moztest == 0.8 08:20:28 INFO - mozversion == 1.4 08:20:28 INFO - psutil == 3.1.1 08:20:28 INFO - requests == 1.2.3 08:20:28 INFO - wsgiref == 0.1.2 08:20:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb2cd5430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5ad30>, '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 0x104981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a4fbe8>, '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.cfmHsolFPV/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.VEOa1yKokA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:20:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfmHsolFPV/Render', 08:20:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:28 INFO - 'HOME': '/Users/cltbld', 08:20:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:28 INFO - 'LOGNAME': 'cltbld', 08:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:28 INFO - 'MOZ_NO_REMOTE': '1', 08:20:28 INFO - 'NO_EM_RESTART': '1', 08:20:28 INFO - 'PAGER': '/bin/cat', 08:20:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:28 INFO - 'PWD': '/builds/slave/test', 08:20:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:28 INFO - 'SHELL': '/bin/bash', 08:20:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VEOa1yKokA/Listeners', 08:20:28 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 08:20:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:28 INFO - 'USER': 'cltbld', 08:20:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:28 INFO - 'XPC_FLAGS': '0x0', 08:20:28 INFO - 'XPC_SERVICE_NAME': '0', 08:20:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:20:28 INFO - Cleaning up... 08:20:28 INFO - Return code: 0 08:20:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb2cd5430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a5ad30>, '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 0x104981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a4fbe8>, '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.cfmHsolFPV/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.VEOa1yKokA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:20:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfmHsolFPV/Render', 08:20:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:28 INFO - 'HOME': '/Users/cltbld', 08:20:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:28 INFO - 'LOGNAME': 'cltbld', 08:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:28 INFO - 'MOZ_NO_REMOTE': '1', 08:20:28 INFO - 'NO_EM_RESTART': '1', 08:20:28 INFO - 'PAGER': '/bin/cat', 08:20:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:28 INFO - 'PWD': '/builds/slave/test', 08:20:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:28 INFO - 'SHELL': '/bin/bash', 08:20:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VEOa1yKokA/Listeners', 08:20:28 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 08:20:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:28 INFO - 'USER': 'cltbld', 08:20:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:28 INFO - 'XPC_FLAGS': '0x0', 08:20:28 INFO - 'XPC_SERVICE_NAME': '0', 08:20:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:20:29 INFO - Cleaning up... 08:20:29 INFO - Return code: 0 08:20:29 INFO - Running post-action listener: _resource_record_post_action 08:20:29 INFO - Running post-action listener: _start_resource_monitoring 08:20:29 INFO - Starting resource monitoring. 08:20:29 INFO - [mozharness: 2017-01-25 16:20:29.212925Z] Finished create-virtualenv step (success) 08:20:29 INFO - [mozharness: 2017-01-25 16:20:29.213937Z] Running install step. 08:20:29 INFO - Running pre-action listener: _resource_record_pre_action 08:20:29 INFO - Running main action method: install 08:20:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:20:29 INFO - Reading from file tmpfile_stdout 08:20:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:20:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:20:29 INFO - Reading from file tmpfile_stdout 08:20:29 INFO - Output received: 08:20:29 INFO - Usage: mozinstall [options] installer 08:20:29 INFO - Options: 08:20:29 INFO - -h, --help show this help message and exit 08:20:29 INFO - -d DEST, --destination=DEST 08:20:29 INFO - Directory to install application into. [default: 08:20:29 INFO - "/builds/slave/test"] 08:20:29 INFO - --app=APP Application being installed. [default: firefox] 08:20:29 INFO - mkdir: /builds/slave/test/build/application 08:20:29 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:20:29 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:20:50 INFO - Reading from file tmpfile_stdout 08:20:50 INFO - Output received: 08:20:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:20:50 INFO - Running post-action listener: _resource_record_post_action 08:20:50 INFO - [mozharness: 2017-01-25 16:20:50.659356Z] Finished install step (success) 08:20:50 INFO - [mozharness: 2017-01-25 16:20:50.659536Z] Running run-tests step. 08:20:50 INFO - Running pre-action listener: _resource_record_pre_action 08:20:50 INFO - Running main action method: run_tests 08:20:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:20:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:20:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:20:50 INFO - 2017-01-25 08:20:50.673 screenresolution[1636:8585] starting screenresolution argv=screenresolution get 08:20:50 INFO - 2017-01-25 08:20:50.676 screenresolution[1636:8585] Display 0: 1600x1200x32@60 08:20:50 INFO - 2017-01-25 08:20:50.681 screenresolution[1637:8591] starting screenresolution argv=screenresolution list 08:20:50 INFO - Available Modes on Display 0 08:20:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:20:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:20:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:20:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:20:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:20:50 INFO - Intel Iris: 08:20:50 INFO - Chipset Model: Intel Iris 08:20:50 INFO - Type: GPU 08:20:50 INFO - Bus: Built-In 08:20:50 INFO - VRAM (Dynamic, Max): 1536 MB 08:20:50 INFO - Vendor: Intel (0x8086) 08:20:50 INFO - Device ID: 0x0a2e 08:20:50 INFO - Revision ID: 0x0009 08:20:50 INFO - Displays: 08:20:50 INFO - Display: 08:20:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:20:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:20:50 INFO - Display Serial Number: 1600x1200 60 08:20:50 INFO - Main Display: Yes 08:20:50 INFO - Mirror: Off 08:20:50 INFO - Online: Yes 08:20:50 INFO - Rotation: Supported 08:20:50 INFO - Return code: 0 08:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:20:50 INFO - Python 2.7.3 08:20:50 INFO - Return code: 0 08:20:50 INFO - grabbing minidump binary from tooltool 08:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:50 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 0x104a5ad30>, '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 0x104981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a4fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:20:50 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:20:50 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:20:50 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:20:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:20:51 INFO - Return code: 0 08:20:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:20:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:20:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:20:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:20:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:20:51 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/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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:20:51 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/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0034 --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:20:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfmHsolFPV/Render', 08:20:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:51 INFO - 'HOME': '/Users/cltbld', 08:20:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:51 INFO - 'LOGNAME': 'cltbld', 08:20:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:20:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:51 INFO - 'MOZ_NO_REMOTE': '1', 08:20:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:20:51 INFO - 'NO_EM_RESTART': '1', 08:20:51 INFO - 'PAGER': '/bin/cat', 08:20:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:51 INFO - 'PWD': '/builds/slave/test', 08:20:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:20:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:51 INFO - 'SHELL': '/bin/bash', 08:20:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VEOa1yKokA/Listeners', 08:20:51 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 08:20:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:51 INFO - 'USER': 'cltbld', 08:20:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:51 INFO - 'XPC_FLAGS': '0x0', 08:20:51 INFO - 'XPC_SERVICE_NAME': '0', 08:20:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:51 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/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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:20:51 INFO - mozversion application_buildid: 20170125065748 08:20:51 INFO - mozversion application_changeset: 47e238a0c9e34e04d7c93cb3367e20c987f9af0d 08:20:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:20:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:20:51 INFO - mozversion application_name: Firefox 08:20:51 INFO - mozversion application_remotingname: firefox-dev 08:20:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:20:51 INFO - mozversion application_vendor: Mozilla 08:20:51 INFO - mozversion application_version: 53.0a2 08:20:51 INFO - mozversion platform_buildid: 20170125065748 08:20:51 INFO - mozversion platform_changeset: 47e238a0c9e34e04d7c93cb3367e20c987f9af0d 08:20:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:20:51 INFO - mozversion platform_version: 53.0a2 08:20:51 INFO - using testdate: 1485361251 08:20:51 INFO - actual date: 1485361251 08:20:51 INFO - starting webserver on 'localhost:49244' 08:20:51 INFO - SUITE-START | Running 2 tests 08:20:51 INFO - TEST-START | dromaeo_css 08:20:51 INFO - operating with platform_type : mac_ 08:20:51 INFO - Initialising browser for dromaeo_css test... 08:20:51 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmp2bYM1d/profile http://localhost:49244/getInfo.html) 08:20:53 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 08:20:53 INFO - PROCESS | 1647 | colorDepth:24 08:20:53 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 08:20:53 INFO - PROCESS | 1647 | __metrics 08:20:54 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 08:20:54 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:20:54 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:20:54 INFO - TEST-INFO | 1647: exit 0 08:20:54 INFO - Browser initialized. 08:20:54 INFO - Running cycle 1/1 for dromaeo_css test... 08:20:54 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmp2bYM1d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:07 INFO - PROCESS | 1650 | RSS: Main: 228741120 08:21:07 INFO - PROCESS | 1650 | 08:24:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 08:24:12 INFO - PROCESS | 1650 | RSS: Main: 370532352 08:24:12 INFO - PROCESS | 1650 | 08:25:57 INFO - PROCESS | 1650 | ************************* 08:25:57 INFO - PROCESS | 1650 | A coding exception was thrown and uncaught in a Task. 08:25:57 INFO - PROCESS | 1650 | 08:25:57 ERROR - PROCESS | 1650 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:25:57 INFO - PROCESS | 1650 | Full stack: 08:25:57 INFO - PROCESS | 1650 | ************************* 08:27:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 08:27:15 INFO - PROCESS | 1650 | RSS: Main: 359849984 08:27:15 INFO - PROCESS | 1650 | 08:30:18 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 08:30:18 INFO - PROCESS | 1650 | RSS: Main: 343416832 08:30:18 INFO - PROCESS | 1650 | 08:33:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 08:33:22 INFO - PROCESS | 1650 | RSS: Main: 331051008 08:33:22 INFO - PROCESS | 1650 | 08:36:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 08:36:26 INFO - PROCESS | 1650 | RSS: Main: 321294336 08:36:26 INFO - PROCESS | 1650 | 08:39:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 08:39:29 INFO - PROCESS | 1650 | RSS: Main: 374751232 08:39:29 INFO - PROCESS | 1650 | 08:39:29 INFO - PROCESS | 1650 | __start_tp_report 08:39:29 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 08:39:29 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 08:39:29 INFO - PROCESS | 1650 | |i|pagename|runs| 08:39:29 INFO - PROCESS | 1650 | |0;dojo.html;2881.078055022393;2902.129361191642;2915.1546051645023;2982.5824384586163;3004.7445967092794;4973.154563724166;5023.372078490189;5044.697318160913;5049.091163590552;5107.846764597063;5007.974960125194;5037.118504261749;5052.141136006879;5060.51925067118;5116.513931176532;4626.930596041046;4634.6755727099035;4736.431628204603;4750.738709370983;4755.191617425029;4545.9545404546025;4559.065391594731;4585.105904348653;4722.244440889458;4722.763861806913;4671.719696818185;4705.576498115169;4716.268978308368;4718.056388722252;4732;4584.839530616429;4617.930731039037;4625.606823419979;4695.812167513295;4701.130290896195;4634.884127896796;4637.397138372024;4669.2062349400685;4669.32294817253;4693.788779504896;4943.184374578191;4957.702537847741;5037.748112594356;5054.519820617035;5070.3915530136255;5297.549708274802;5354.625176237665;5357.303550538444;5458.5087342139395;5549.944500554983;5595.608307418483;5610.523105536035;5629.746661400247;5649.548036157097;5688.857778555528;5213.843584692465;5233.398159211663;5235.136202526616;5246;5271.20931860224;5516.420775818561;5625.409332020161;5640.8871822563315;5739.225204597409;5749.338826035059;5319.654222475604;5325.520703136659;5350.51845333914;5482.890342193134;5506.862328441821;5619.522340601013;5622.0161471742285;5626.606137570331;5638.6052976292085;5653.830385088454;5492.286002819608;5504.422035686275;5515.7242137893745;5518.2826232589505;5551.639143455663;5218.973905130526;5348.732563371894;5350.411454739976;5479.424660410679;5489.64317319373;4405.493368262627;4469.575390337913;4470.329450582373;4475.30632751924;4534.02518458533;3970.265500882346;4001.6198461146146;4003.2288926094143;4007.957930937977;4045.7370270932297;4904.681195722266;4922.950770492249;4926.827561035347;4937.481564435682;4954.455009948902;5234.241035049897;5403.891922161535;5437.374701909252;5459;5524.4199359067525;4707.764611769398;4785.952140478551;4804.663673542888;4894.926576101361;4977.129002424634;4893.535114164149;4970.502949705001;4972.90054198914;4974.925376119361;4975.4527002029745;4826.372571565744;5803.274590676166;5819.82540523785;5861.3552509223955;5890.469857712741;5356.116240820221;5633.718314084362;5643.012472817322;5647.548196144381;5654.773809047592;5667.40492248308;5703.315602127771;5731.484166425042;5759.107338362561;5795.188673585617;4925.753712314442;5176.145935920531;5531.474509921551;5539.750711218086;5565.7217139143695;5545.946270208648;5594.38461769197;5604.355499117491;5610.354809196994;5612.382637909745;4740.6444516660695;5007.7746501408255;5134.614903882149;5255.947440525546;5366.302380690485;4419.270820314612;5276.34045744282;5359.651622644516;5363.19552067193;5377.354717433933;5257.132573125545;5273.920891186559;5288.471152884681;5297.2583838263445;5327.866803329948;5167.974160129325;5255.579553635776;5375.704336261543;5375.731213439234;5387.595930305164;5136.409312928911;5195.5583775378;5212.609054321017;5280.128778751617;5297.735113244245 08:39:29 INFO - PROCESS | 1650 | |1;ext.html;400.2495321272614;423.86648205815175;441.955804419558;449.9572540608641;476.80212711724636;25514.234572962818;39602.80198599007;41536.58463415365;41622.58377416229;41929.79035104828;42510.78744606273;42934.141317173635;42945.57054429455;42955.57044429555;42973.78513107438;9064.546772661373;9276.165145136936;9292.303077269198;9300.674476393327;9315.161635452809;8191.549464779435;8441.788955276106;10965.287256328313;11231.494582743797;11263.887361126406;11238.831417528743;11293.943530282337;11313.321200727942;11316.773664526705;11325.207235493519;10804.297720648132;11099.001089901907;11142.832857507063;11197.328160310408;11237.21339506239;8139.4709343892455;8377.329813614897;10737.892621073768;10983.890161098367;11023.228374013823;40436;40912.38631420531;40945.79527102375;40970.590294096975;41022.38466423006;3904.7852368119743;3921.215756848613;3942.546607140187;3969.4442778011103;3970.06703424695;26980.730192698018;27739.861300693367;27936.58095128575;28112.016079437326;29258.853705731548;3087.3825234952874;3094.149108995022;3135.843207839599;3180.5547223388744;3187.6493585705553;457262;457699.9999999967;460171;461595;461818;56747.43252567504;57145.14282285769;57199.714001429726;57394.426055738906;57492.97549171518;59468.40531594715;59486.70256648689;59525.70237148873;59564.80870382568;59645.70177149173;15284.770728439082;15756.92121539385;15766.9211653941;15791.36834526606;15804.36782528709;11924.821127683092;12197.634070977885;12288.815667764991;12313.56902508408;12321.260724356567;15273.159976201194;15652.217389130497;15702.842971570139;17350.56623584395;17846.732299015526;6608.2730899601;7601.315881570686;7769.251918318333;7855.371570274365;7864.84270314602;733.1422235983912;770.5107256891802;774.8334108166771;777.2654841175148;790.083503136359;25591.976320946953;28858.134255972356;29244.415111697646;29630.40739185204;29736.650691005452;998.510729742421;1001.4341896828269;1011.8482227665909;1012.4735137728487;1132.694172573417;14900.925495372454;15383.38466461329;15467.690646187239;15717.764233536505;15787.28957196929;609594;610583;616943.9152804296;620271.8986405039;620627;61117.694411528544;61168;61200;61321;61788.69105654533;1199.9200719352305;1335.599320203935;1355.830521184852;1375.532319011521;1379.620604333796;27958.3010424741;28913.132606021853;28923.987660431783;29102.56346154767;29704.25739356447;51449.742751286;51495.45513634597;51701.741491292305;51753.482465174864;51798;501760;503492;504949;506423;507673;26164.476710466064;26545.867270663523;26582.936682533254;26610.06864759724;26624;37433.62566374301;43347.56652433561;46218.53781462142;49644.25533616926;50094.74952625213;38712.41931371088;38800.41799372955;39210.2157956845;39376;40637.79681101575;38378.808105959295;38652.8404147876;38777.61222387853;40144.795656130365;40151;36792;37228;37814.62185378111;37815.62184378121;38051.80974095112;32748.345033099682;33804.66195338113;34407.31185376229;34604.65395346115;34795;24549.38626534351;24664.506709866062;24800.627990579796;25108.372290692878;25276.873615631805 08:39:29 INFO - PROCESS | 1650 | |2;jquery.html;334.19035920490546;336.725568661541;354.9645035496449;370.7164019525064;389.55590626685586;13800.930995345021;14434.566962991114;15179.2410379481;20252.493687657818;20732;20047.398578042645;20627.38117856463;20743.688844667344;21023.47441313968;21497;5513.393526712059;5854.736536855852;5870.383609720981;5881.117832325164;5901.4688678018965;4782.545658162469;5768.682722450264;5823.767049318022;5826.912596311037;5830.154627578999;5716.857078573027;5775.826725198251;5783;5791.407362975195;5799.652020878761;5560.443955604427;5864.882702345951;5919.467247947706;5965.642061476282;5972.432618901197;5647.661140331593;5768.538516918678;5828.6211396259105;5864.091065884794;5883.029300165467;13201.933990329986;13403.530876419376;13409.396577153953;13441.462341506329;21489.140434382763;2541.8474891506567;2555.821092523524;2558.398776287571;2576.6779152605923;2673.719259477746;9846.064623860722;10162.524756909574;14012.719745605133;15078.773818392732;15829.525114246591;1785.9464216073538;1799.3522331960485;1834.871558990871;1837.9448616541524;1844.1516902224992;118090;132441;133399;137014.60313652566;138879;11295.943520282346;11380.317180969168;11438.885611143949;11466.54133834654;11604.303741775351;14636.121832690073;14994.850051499345;15151.318190681446;15193.772093418607;15268.770968435483;7559.5464272143845;8466.703665371806;8479.915200848036;8582.313414926792;8583;8422.578871056423;8428.915710842935;8454.66181352739;8550.914490855012;8574.742757717278;4659.627229821606;4668.276417155346;4679.368285281444;4687.695299805502;4772.856814295507;1906.7044608085769;1963.4306051245264;1969.960600788005;1970.615729932678;1975.1506852053467;722.512304194677;771.1440301265591;773.9264769846856;780.679921232292;798.6645608844183;20632.381028569165;21531.461713456974;21579.89210053971;21582.676259856114;21640.458988525097;821.4947807098591;831.5343407691712;836.2181360428019;854.5684429363132;858.6908712863365;9283.860742088875;10251.897481025244;11076.224664273584;11315.094792416752;11500.367479788692;395454;549828;681304;684699;714516;133291.3335433336;140679;140927;142007.37926317184;142317.5768242325;914.4604683236922;917.8026724254318;946.3044662173435;951.6336210558846;951.8286708392556;18620.906895465978;18996.335128270443;19253.90373048126;19263.614727705088;19264.90367548153;52568;54192.45807541874;54315;55225.72387138199;57246.42753572578;74241.25758742343;74537.39119131022;76826.61586692031;77240;77708.8343674834;6985.511014228955;7838.64726087316;7882.9605851972665;7984.720534781255;8168.754937351889;7797.493162944391;11956.103292252941;12416;12485;12729.172603780724;10555.89444105549;10580.576776928836;10588.10001149911;10716.089132423831;10920.617778377718;10507.31702439339;10637.255392122786;10686.465676715978;10699.94650026745;10887.020168184901;10822.837657435302;10835.51240194209;10926;11029.944850276019;11166.497507612014;8029.7189598363775;8086.029676438865;8092.959535202286;8213.835723285381;8224.38317126206;8218.21926916942;10618.469076546296;10650.786984260427;10676.46617669129;10742.140628749838 08:39:29 INFO - PROCESS | 1650 | |3;mootools.html;1253.9435725392357;1363.250212383189;1370.5545697648263;1388.2364699415323;1392.7632302508573;6344.3338449462835;7058.576485410879;7654.808629784258;7990.760277191686;8217.972753405824;8085.029796424437;8098.149694282104;8120.147384524628;8170.305524030449;8170.509769413825;1946.6301402733436;2212.8008479236864;2251.223327951854;2255.740589832166;2259.8418110732255;2054;2160.5138843760187;2247.4830788918557;2255.560165767676;2272.5682120397073;2207.073029327686;2213;2220.85564438311;2220.955580888381;2222.422170235742;2149.161826887515;2175.7171567696255;2182.3562049195525;2186.0709198590694;2195.736511618608;2167.2522979572022;2172.9565408691897;2246.8876556172127;2251.2683377902085;2254.537819746948;8144.877826832543;8186.426950113494;8193.959030204871;8205.876911846268;8210.794730131734;4869.951300486985;4970.229614409736;5038.96701176258;5050.823221187241;5051.848444546669;3207.903762887117;3326.750493712957;3349.464085746269;3387.796732196076;3448.0173150652195;1129.5877004893237;1170.5083864776814;1180.9527618895233;1201.0151675625991;1227.3495047624774;10432.061114499731;10450.843237351522;10469;10490.947545262301;10492.055714985689;4191.266528357525;4381.539938306496;4422.336649502536;4574.565416285448;4603.263477843529;8406.327493800482;8474.830503389898;8478.74563763088;8481.660733570712;8489.533075680773;4947.282644016669;4953;4953.00939812039;4954.157793175169;4959.454460009396;4166.145940082337;4528.682992190581;4610.4467463903875;4616.0998605272325;4620.815167393266;2964.540496223046;3326.900192994214;3492.9695739756835;3606.8016259105475;3616.023673608111;1080.5515710979855;1111.698783518126;1123.2586492914636;1123.9831402528969;1128.7121783945042;799.5282783157849;803.6423791412765;815.4821688228018;819.7909533069029;825.8513467575895;5308.601854860901;5456.781728730885;5633.408492108351;5724.713764311768;5788.102844059177;829.4649950781833;871.899731530882;872.7294538693026;876.8509353409936;882.52343734384;3578.6779189873037;3589.5692516897616;3622.42041273395;3700.4634328022285;3737.4954381158195;9195.862062069074;9277.443353398818;9539.427634341962;9719.319647624598;9740.220782337396;9588.76028099303;9721.9027809721;9732.2214222862;9748.830140383057;9753.512324383752;7189.676464559107;7505.924940750632;7545.849083018309;7554.017977662978;7620.657070431844;5237.580993520585;5314.681119132864;5423.864403389947;5543.667379957215;5851.678157701197;8861.955690221508;8944.910550894409;8986.460812351279;9038.231750301298;9084.091590840862;8658.307335413027;9072.727818165466;9181.081891810765;9258.72223833286;9297.116773906468;6804.21751498584;7118.25258347866;7120.216776154515;7121.857562848818;7129.322714342129;7102.502824802421;7224.458165637493;7297.489175757646;7718.189590092959;7794.103678077094;6938.202106757585;6950.478714096362;6953.478489113236;7134.036905017963;7137.607431591312;6780.118584583973;6819.454443644596;6827.112475378169;6849.31506849331;6857.348551887762;6165.815025549241;6168.568200225941;6230.6884655766125;6253.530985176039;6256.343083976299;4262.46719160105;4701.788419521198;4792.688475249237;4910.975445122752;4942.802287908444;4251.511076226274;4759.690620109682;4834.7824347903725;4879.829205977774;4955.1823949048 08:39:29 INFO - PROCESS | 1650 | |4;prototype.html;320.5240218275861;320.5464268060694;330.60657817197534;334.0679504183329;335.6777493606138;3862.497875276217;4172;4235.597618226271;4246.660267178626;4274.679399045072;3838.694843753123;3983.6813054955605;4029.3351596986536;4050.574689657588;4157.501099868013;2844.904711685995;2954.739624187498;3319.937619961613;3337.699607035366;3380.951904909474;3371.73026157908;3379.3241351729753;3408.84660190292;3409.267007593367;3455.118944669106;3139.571494969783;3367;3402.6767457091537;3434.965650343502;3437.5390459054925;2714.674239091302;2867.7562407195414;3257.6579459156683;3377.307651931348;3401.727861771065;3017.5624534442604;3020.3506246156962;3050.8339079253756;3058.29659178388;3083.861226244802;3990.940135897964;4016.3373043447796;4026.2148880968225;4032.5362583303004;4058.6955978301744;3703.092742278132;3799.3351163546545;3809.657130858236;3845.692344612424;3845.9230815383817;3845.61543845616;3923.784191869446;4450.599446049871;4460.219461594241;4488.663350248712;3371.5448414463976;3377.746668999835;3382.004617275819;3382.410267174424;3385.339858727549;4477.925297928507;4534.274516077412;4612.423447069116;4622.329762184464;4666.673332866701;3302.53764472974;3394.710010196159;3413.4367829307885;3416.4533674611944;3428.8285585720614;3485.2506711057245;3488.284901595167;3491.8952431427097;3494.056604716712;3500.899460323785;3405.1316914186723;3516.40221162403;3851.5955824638568;3874.6900247980093;3905.0042239228815;3813.427985802152;4158.897892058607;4526.072155208174;4546.772661366985;4560.931586026146;979.8775153105862;1058.9046985771317;1112.5425692343056;1119.0152665654334;1144.856892888389;712.5297303779481;761.584936209767;782.5383024015858;807.7495976247382;818.7339114787718;3278.7868788528667;3290.9431605246723;3578.6600272974024;3688.907777305535;3905.500479692999;3787.981060094737;4365.432493775852;4500.257457519473;4515.9774201128785;4525.932111018337;3473.565804274466;3707.573629032696;3714.9598112528533;4022.416749571354;4032.3749818778138;1904.9428517144509;2030.6852437872153;2191.6931629571873;2205.558888222362;2206.9227577034726;4396.054848207651;4397.31841564558;4397.648188144941;4408.691391602557;4458.509563947963;3992.48097747291;4027.677785777131;4359.673024523174;4380.934285985712;4432.894375171768;4101.630853223224;4228.9154216915485;4283.5502272260965;4397.868063958151;4583.610393116555;3858.401947698111;4495.100979803987;4582.564656357641;4583.564561366665;4642.37327960721;4344.978929951522;4564.680472366902;4584.4498660161;4586.610138138296;4587.24310488779;4375.606195442426;4716.457607375059;4747.738874361943;4784.330193772944;4784.497627749175;2770.944581108326;2952.586637870657;3234.649396561621;3235.8350993641798;3266.8693252269645;3823.9617603823604;4075.5720649331392;4540.502723501994;4548.135854187693;4584.656150788637;4332.465507677917;4471.552844715502;4491.360653361565;4493.73037617744;4541.707262234853;4302.139572085658;4442.955570444384;4507.977460112678;4516.728996260234;4520.073384956142;3918.4710064140977;4068.9420750604463;4407.537208593051;4452.62905737212;4481.521098037574;4018.7186896916937;4127.938080928849;4444.222261104358;4460.553944605514;4475.7985890634345;3581.4985901974264;4134.834606615702;4278.465191851019;4376.606105450524;4391.912161756811 08:39:29 INFO - PROCESS | 1650 | |5;yui.html;673.4141297071549;686.9072675188851;745.9552426854389;787.2993036197784;795.2484901767829;14548.854511454896;15614.063156210606;15633.296501657424;15637.296321665524;15653;13903.374348154332;13963.301834908265;14150.363233654485;14312.998090133695;14379.928100359484;712.2450202785064;810.1776696652902;842.1704620948361;842.3892677808601;842.4355681693249;832.8917240758693;839.0518713853368;839.7564706235215;840.2060053249681;840.2437805974611;883.8276536075468;884.3014018925041;884.747846863644;884.7743825324533;886.8847049883539;860.5783166248556;883.924866386358;884.3809333466567;884.4118661090367;889.5596679643553;657.5364368120463;657.539722194461;657.8486948001938;658.9835254118638;666.1207206487438;13244.933775331157;14460.710785784331;14968.101913885093;15121.092734435859;15482.5355239343;13614.047016708835;13726.93136534321;13789.724205515933;13908.860911390959;13954.93022534891;11170;11194.776104477865;11213.215074944757;11584.42077896102;11758.353290569015;3604.53141091659;3632.7275454340765;3643.890683279506;3709.4806727058235;3754;79817;100439;102080;103056;104460.95539044589;9913.355631883904;10344.896551034393;10350.844737328945;10697.946510267398;10768.730781730363;20241.898790505955;21852.907354632203;21878.89060554719;21896.233631822808;21919.232826850985;7558.357539609195;7619.580923049175;7627.923720762832;7645.541267523855;7809.336206422404;4182.2681030819485;4193.098483825992;4268.957310426856;4310.698251122391;4442.222611043055;3512.648735126467;3541.8229088545468;3557.8043207623314;3617.909552261162;3622.873199438007;648.2868844271264;649.4187702006677;650.2554575011679;652.8335274505066;660.1912656995142;501.34073693093467;619.5136817598163;626.8495561065312;641.3169973977699;644.365300179323;9251.444913305224;10017.08703427856;10031.949840250752;10265.281430299956;10487.685369438928;618.9972244963099;632.6552029144127;635.5582869905371;643.3020173112133;643.9420452159235;4908.509149085135;4957.752112394366;4961.751912404366;4963.503649635008;4971.502849715;100795.99204007867;101557;102517.97482025085;104100;104766;84429.15570844336;85667;87832.5608371954;88049.55975220083;88980.11019889847;76735.46529069387;78170;79159.60420197978;79681;79716;8195.590220489072;9465.621375145192;9542.904570954202;9583.424994500352;9654.2276617869;39748.80125599354;49298.014039718284;49922.75038624783;50423.45147662564;51797.482025180776;49782.75108624434;66669;67006;68304.63390732057;69745.30254697388;10874.67375978722;11241.044511216638;11270.661880143609;11456.891547975281;11489.138314626269;12149.75700486003;12225.87774122283;12401.565945191875;12457;12711.872881271438;11239.325640461271;11386.94306528462;11393.487293071666;12022.819657704966;12379.071569632133;11636;11721.179517433698;11722.824157637813;12015.75968480608;12058.216215945935;11581.131415144066;11773.705657358634;11784.941075294568;12146.08904332161;12307.26156430617;9182.724518264462;9373.953130234306;9559.61761529531;9771.169450596779;9797.902020979984;7898.973133492609;8477.448965817202;9130.178283954476;9207.956312034292;9382.249420046244 08:39:29 INFO - PROCESS | 1650 | __end_tp_report 08:39:29 INFO - PROCESS | 1650 | __start_cc_report 08:39:29 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1520 08:39:29 INFO - PROCESS | 1650 | __end_cc_report 08:39:29 INFO - PROCESS | 1650 | __startTimestamp1485362369503__endTimestamp 08:39:29 INFO - PROCESS | 1650 | 08:39:29 INFO - PROCESS | 1650 | ------- Summary: start ------- 08:39:29 INFO - PROCESS | 1650 | Number of tests: 6 08:39:29 INFO - PROCESS | 1650 | 08:39:29 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5086.00 Median:5218.97 stddev:568.76 (10.9%) stddev-sans-first:543.57 08:39:29 INFO - PROCESS | 1650 | Values: 2881.1 2902.1 2915.2 2982.6 3004.7 4973.2 5023.4 5044.7 5049.1 5107.8 5008.0 5037.1 5052.1 5060.5 5116.5 4626.9 4634.7 4736.4 4750.7 4755.2 4546.0 4559.1 4585.1 4722.2 4722.8 4671.7 4705.6 4716.3 4718.1 4732.0 4584.8 4617.9 4625.6 4695.8 4701.1 4634.9 4637.4 4669.2 4669.3 4693.8 4943.2 4957.7 5037.7 5054.5 5070.4 5297.5 5354.6 5357.3 5458.5 5549.9 5595.6 5610.5 5629.7 5649.5 5688.9 5213.8 5233.4 5235.1 5246.0 5271.2 5516.4 5625.4 5640.9 5739.2 5749.3 5319.7 5325.5 5350.5 5482.9 5506.9 5619.5 5622.0 5626.6 5638.6 5653.8 5492.3 5504.4 5515.7 5518.3 5551.6 5219.0 5348.7 5350.4 5479.4 5489.6 4405.5 4469.6 4470.3 4475.3 4534.0 3970.3 4001.6 4003.2 4008.0 4045.7 4904.7 4923.0 4926.8 4937.5 4954.5 5234.2 5403.9 5437.4 5459.0 5524.4 4707.8 4786.0 4804.7 4894.9 4977.1 4893.5 4970.5 4972.9 4974.9 4975.5 4826.4 5803.3 5819.8 5861.4 5890.5 5356.1 5633.7 5643.0 5647.5 5654.8 5667.4 5703.3 5731.5 5759.1 5795.2 4925.8 5176.1 5531.5 5539.8 5565.7 5545.9 5594.4 5604.4 5610.4 5612.4 4740.6 5007.8 5134.6 5255.9 5366.3 4419.3 5276.3 5359.7 5363.2 5377.4 5257.1 5273.9 5288.5 5297.3 5327.9 5168.0 5255.6 5375.7 5375.7 5387.6 5136.4 5195.6 5212.6 5280.1 5297.7 08:39:29 INFO - PROCESS | 1650 | 08:39:29 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:66485.80 Median:38789.02 stddev:141554.10 (364.9%) stddev-sans-first:141864.24 08:39:29 INFO - PROCESS | 1650 | Values: 400.2 423.9 442.0 450.0 476.8 25514.2 39602.8 41536.6 41622.6 41929.8 42510.8 42934.1 42945.6 42955.6 42973.8 9064.5 9276.2 9292.3 9300.7 9315.2 8191.5 8441.8 10965.3 11231.5 11263.9 11238.8 11293.9 11313.3 11316.8 11325.2 10804.3 11099.0 11142.8 11197.3 11237.2 8139.5 8377.3 10737.9 10983.9 11023.2 40436.0 40912.4 40945.8 40970.6 41022.4 3904.8 3921.2 3942.5 3969.4 3970.1 26980.7 27739.9 27936.6 28112.0 29258.9 3087.4 3094.1 3135.8 3180.6 3187.6 457262.0 457700.0 460171.0 461595.0 461818.0 56747.4 57145.1 57199.7 57394.4 57493.0 59468.4 59486.7 59525.7 59564.8 59645.7 15284.8 15756.9 15766.9 15791.4 15804.4 11924.8 12197.6 12288.8 12313.6 12321.3 15273.2 15652.2 15702.8 17350.6 17846.7 6608.3 7601.3 7769.3 7855.4 7864.8 733.1 770.5 774.8 777.3 790.1 25592.0 28858.1 29244.4 29630.4 29736.7 998.5 1001.4 1011.8 1012.5 1132.7 14900.9 15383.4 15467.7 15717.8 15787.3 609594.0 610583.0 616943.9 620271.9 620627.0 61117.7 61168.0 61200.0 61321.0 61788.7 1199.9 1335.6 1355.8 1375.5 1379.6 27958.3 28913.1 28924.0 29102.6 29704.3 51449.7 51495.5 51701.7 51753.5 51798.0 501760.0 503492.0 504949.0 506423.0 507673.0 26164.5 26545.9 26582.9 26610.1 26624.0 37433.6 43347.6 46218.5 49644.3 50094.7 38712.4 38800.4 39210.2 39376.0 40637.8 38378.8 38652.8 38777.6 40144.8 40151.0 36792.0 37228.0 37814.6 37815.6 38051.8 32748.3 33804.7 34407.3 34604.7 34795.0 24549.4 24664.5 24800.6 25108.4 25276.9 08:39:29 INFO - PROCESS | 1650 | 08:39:29 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:35571.23 Median:1503.95 stddev:103595.91 (6888.2%) stddev-sans-first:103852.73 08:39:29 INFO - PROCESS | 1650 | Values: 334.2 336.7 355.0 370.7 389.6 13800.9 14434.6 15179.2 20252.5 20732.0 20047.4 20627.4 20743.7 21023.5 21497.0 5513.4 5854.7 5870.4 5881.1 5901.5 4782.5 5768.7 5823.8 5826.9 5830.2 5716.9 5775.8 5783.0 5791.4 5799.7 5560.4 5864.9 5919.5 5965.6 5972.4 5647.7 5768.5 5828.6 5864.1 5883.0 13201.9 13403.5 13409.4 13441.5 21489.1 2541.8 2555.8 2558.4 2576.7 2673.7 9846.1 10162.5 14012.7 15078.8 15829.5 1785.9 1799.4 1834.9 1837.9 1844.2 118090.0 132441.0 133399.0 137014.6 138879.0 11295.9 11380.3 11438.9 11466.5 11604.3 14636.1 14994.9 15151.3 15193.8 15268.8 7559.5 8466.7 8479.9 8582.3 8583.0 8422.6 8428.9 8454.7 8550.9 8574.7 4659.6 4668.3 4679.4 4687.7 4772.9 1906.7 1963.4 1970.0 1970.6 1975.2 722.5 771.1 773.9 780.7 798.7 20632.4 21531.5 21579.9 21582.7 21640.5 821.5 831.5 836.2 854.6 858.7 9283.9 10251.9 11076.2 11315.1 11500.4 395454.0 549828.0 681304.0 684699.0 714516.0 133291.3 140679.0 140927.0 142007.4 142317.6 914.5 917.8 946.3 951.6 951.8 18620.9 18996.3 19253.9 19263.6 19264.9 52568.0 54192.5 54315.0 55225.7 57246.4 74241.3 74537.4 76826.6 77240.0 77708.8 6985.5 7838.6 7883.0 7984.7 8168.8 7797.5 11956.1 12416.0 12485.0 12729.2 10555.9 10580.6 10588.1 10716.1 10920.6 10507.3 10637.3 10686.5 10699.9 10887.0 10822.8 10835.5 10926.0 11029.9 11166.5 8029.7 8086.0 8093.0 8213.8 8224.4 8218.2 10618.5 10650.8 10676.5 10742.1 08:39:29 INFO - PROCESS | 1650 | 08:39:29 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5226.16 Median:5273.09 stddev:2858.45 (54.2%) stddev-sans-first:2850.87 08:39:29 INFO - PROCESS | 1650 | Values: 1253.9 1363.3 1370.6 1388.2 1392.8 6344.3 7058.6 7654.8 7990.8 8218.0 8085.0 8098.1 8120.1 8170.3 8170.5 1946.6 2212.8 2251.2 2255.7 2259.8 2054.0 2160.5 2247.5 2255.6 2272.6 2207.1 2213.0 2220.9 2221.0 2222.4 2149.2 2175.7 2182.4 2186.1 2195.7 2167.3 2173.0 2246.9 2251.3 2254.5 8144.9 8186.4 8194.0 8205.9 8210.8 4870.0 4970.2 5039.0 5050.8 5051.8 3207.9 3326.8 3349.5 3387.8 3448.0 1129.6 1170.5 1181.0 1201.0 1227.3 10432.1 10450.8 10469.0 10490.9 10492.1 4191.3 4381.5 4422.3 4574.6 4603.3 8406.3 8474.8 8478.7 8481.7 8489.5 4947.3 4953.0 4953.0 4954.2 4959.5 4166.1 4528.7 4610.4 4616.1 4620.8 2964.5 3326.9 3493.0 3606.8 3616.0 1080.6 1111.7 1123.3 1124.0 1128.7 799.5 803.6 815.5 819.8 825.9 5308.6 5456.8 5633.4 5724.7 5788.1 829.5 871.9 872.7 876.9 882.5 3578.7 3589.6 3622.4 3700.5 3737.5 9195.9 9277.4 9539.4 9719.3 9740.2 9588.8 9721.9 9732.2 9748.8 9753.5 7189.7 7505.9 7545.8 7554.0 7620.7 5237.6 5314.7 5423.9 5543.7 5851.7 8862.0 8944.9 8986.5 9038.2 9084.1 8658.3 9072.7 9181.1 9258.7 9297.1 6804.2 7118.3 7120.2 7121.9 7129.3 7102.5 7224.5 7297.5 7718.2 7794.1 6938.2 6950.5 6953.5 7134.0 7137.6 6780.1 6819.5 6827.1 6849.3 6857.3 6165.8 6168.6 6230.7 6253.5 6256.3 4262.5 4701.8 4792.7 4911.0 4942.8 4251.5 4759.7 4834.8 4879.8 4955.2 08:39:29 INFO - PROCESS | 1650 | 08:39:29 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:3634.78 Median:4017.53 stddev:1060.02 (26.4%) stddev-sans-first:1033.39 08:39:29 INFO - PROCESS | 1650 | Values: 320.5 320.5 330.6 334.1 335.7 3862.5 4172.0 4235.6 4246.7 4274.7 3838.7 3983.7 4029.3 4050.6 4157.5 2844.9 2954.7 3319.9 3337.7 3381.0 3371.7 3379.3 3408.8 3409.3 3455.1 3139.6 3367.0 3402.7 3435.0 3437.5 2714.7 2867.8 3257.7 3377.3 3401.7 3017.6 3020.4 3050.8 3058.3 3083.9 3990.9 4016.3 4026.2 4032.5 4058.7 3703.1 3799.3 3809.7 3845.7 3845.9 3845.6 3923.8 4450.6 4460.2 4488.7 3371.5 3377.7 3382.0 3382.4 3385.3 4477.9 4534.3 4612.4 4622.3 4666.7 3302.5 3394.7 3413.4 3416.5 3428.8 3485.3 3488.3 3491.9 3494.1 3500.9 3405.1 3516.4 3851.6 3874.7 3905.0 3813.4 4158.9 4526.1 4546.8 4560.9 979.9 1058.9 1112.5 1119.0 1144.9 712.5 761.6 782.5 807.7 818.7 3278.8 3290.9 3578.7 3688.9 3905.5 3788.0 4365.4 4500.3 4516.0 4525.9 3473.6 3707.6 3715.0 4022.4 4032.4 1904.9 2030.7 2191.7 2205.6 2206.9 4396.1 4397.3 4397.6 4408.7 4458.5 3992.5 4027.7 4359.7 4380.9 4432.9 4101.6 4228.9 4283.6 4397.9 4583.6 3858.4 4495.1 4582.6 4583.6 4642.4 4345.0 4564.7 4584.4 4586.6 4587.2 4375.6 4716.5 4747.7 4784.3 4784.5 2770.9 2952.6 3234.6 3235.8 3266.9 3824.0 4075.6 4540.5 4548.1 4584.7 4332.5 4471.6 4491.4 4493.7 4541.7 4302.1 4443.0 4508.0 4516.7 4520.1 3918.5 4068.9 4407.5 4452.6 4481.5 4018.7 4127.9 4444.2 4460.6 4475.8 3581.5 4134.8 4278.5 4376.6 4391.9 08:39:29 INFO - PROCESS | 1650 | 08:39:29 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:19663.50 Median:4959.75 stddev:28635.48 (577.4%) stddev-sans-first:28680.31 08:39:29 INFO - PROCESS | 1650 | Values: 673.4 686.9 746.0 787.3 795.2 14548.9 15614.1 15633.3 15637.3 15653.0 13903.4 13963.3 14150.4 14313.0 14379.9 712.2 810.2 842.2 842.4 842.4 832.9 839.1 839.8 840.2 840.2 883.8 884.3 884.7 884.8 886.9 860.6 883.9 884.4 884.4 889.6 657.5 657.5 657.8 659.0 666.1 13244.9 14460.7 14968.1 15121.1 15482.5 13614.0 13726.9 13789.7 13908.9 13954.9 11170.0 11194.8 11213.2 11584.4 11758.4 3604.5 3632.7 3643.9 3709.5 3754.0 79817.0 100439.0 102080.0 103056.0 104461.0 9913.4 10344.9 10350.8 10697.9 10768.7 20241.9 21852.9 21878.9 21896.2 21919.2 7558.4 7619.6 7627.9 7645.5 7809.3 4182.3 4193.1 4269.0 4310.7 4442.2 3512.6 3541.8 3557.8 3617.9 3622.9 648.3 649.4 650.3 652.8 660.2 501.3 619.5 626.8 641.3 644.4 9251.4 10017.1 10031.9 10265.3 10487.7 619.0 632.7 635.6 643.3 643.9 4908.5 4957.8 4961.8 4963.5 4971.5 100796.0 101557.0 102518.0 104100.0 104766.0 84429.2 85667.0 87832.6 88049.6 88980.1 76735.5 78170.0 79159.6 79681.0 79716.0 8195.6 9465.6 9542.9 9583.4 9654.2 39748.8 49298.0 49922.8 50423.5 51797.5 49782.8 66669.0 67006.0 68304.6 69745.3 10874.7 11241.0 11270.7 11456.9 11489.1 12149.8 12225.9 12401.6 12457.0 12711.9 11239.3 11386.9 11393.5 12022.8 12379.1 11636.0 11721.2 11722.8 12015.8 12058.2 11581.1 11773.7 11784.9 12146.1 12307.3 9182.7 9374.0 9559.6 9771.2 9797.9 7899.0 8477.4 9130.2 9208.0 9382.2 08:39:29 INFO - PROCESS | 1650 | -------- Summary: end -------- 08:39:29 INFO - PROCESS | 1650 | 08:39:30 INFO - TEST-INFO | 1650: exit 0 08:39:30 INFO - TEST-OK | dromaeo_css | took 1118920ms 08:39:30 INFO - TEST-START | kraken 08:39:30 INFO - operating with platform_type : mac_ 08:39:30 INFO - Initialising browser for kraken test... 08:39:30 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmp_xqUsm/profile http://localhost:49244/getInfo.html) 08:39:32 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 08:39:32 INFO - PROCESS | 1656 | colorDepth:24 08:39:32 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 08:39:32 INFO - PROCESS | 1656 | __metrics 08:39:32 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 08:39:32 INFO - PROCESS | 1656 | 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:39:32 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:39:33 INFO - TEST-INFO | 1656: exit 0 08:39:33 INFO - Browser initialized. 08:39:33 INFO - Running cycle 1/1 for kraken test... 08:39:33 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmp_xqUsm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:45 INFO - PROCESS | 1657 | RSS: Main: 231477248 08:39:45 INFO - PROCESS | 1657 | 08:39:48 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 08:39:49 INFO - PROCESS | 1657 | RSS: Main: 279842816 08:39:49 INFO - PROCESS | 1657 | 08:39:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 08:39:52 INFO - PROCESS | 1657 | RSS: Main: 293720064 08:39:52 INFO - PROCESS | 1657 | 08:39:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 08:39:57 INFO - PROCESS | 1657 | RSS: Main: 381579264 08:39:57 INFO - PROCESS | 1657 | 08:39:59 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 08:39:59 INFO - PROCESS | 1657 | RSS: Main: 287465472 08:39:59 INFO - PROCESS | 1657 | 08:40:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:02 INFO - PROCESS | 1657 | RSS: Main: 291061760 08:40:02 INFO - PROCESS | 1657 | 08:40:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 08:40:05 INFO - PROCESS | 1657 | RSS: Main: 330678272 08:40:05 INFO - PROCESS | 1657 | 08:40:08 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 08:40:09 INFO - PROCESS | 1657 | RSS: Main: 330031104 08:40:09 INFO - PROCESS | 1657 | 08:40:12 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 08:40:13 INFO - PROCESS | 1657 | RSS: Main: 326287360 08:40:13 INFO - PROCESS | 1657 | 08:40:14 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:40:15 INFO - PROCESS | 1657 | RSS: Main: 306245632 08:40:15 INFO - PROCESS | 1657 | 08:40:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:40:18 INFO - PROCESS | 1657 | RSS: Main: 307511296 08:40:18 INFO - PROCESS | 1657 | 08:40:20 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:40:21 INFO - PROCESS | 1657 | RSS: Main: 309698560 08:40:21 INFO - PROCESS | 1657 | 08:40:24 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:40:24 INFO - PROCESS | 1657 | RSS: Main: 328232960 08:40:24 INFO - PROCESS | 1657 | 08:40:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:40:28 INFO - PROCESS | 1657 | RSS: Main: 322322432 08:40:28 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 08:40:30 INFO - PROCESS | 1657 | RSS: Main: 366706688 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | __start_tp_report 08:40:30 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 08:40:30 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 08:40:30 INFO - PROCESS | 1657 | |i|pagename|runs| 08:40:30 INFO - PROCESS | 1657 | |0;ai-astar;116;119;118;119;120;174;164;117;119;118 08:40:30 INFO - PROCESS | 1657 | |1;audio-beat-detection;145;114;113;147;118;111;125;114;131;112 08:40:30 INFO - PROCESS | 1657 | |2;audio-dft;215;212;212;214;213;212;213;214;213;212 08:40:30 INFO - PROCESS | 1657 | |3;audio-fft;83;61;61;90;62;59;61;60;76;59 08:40:30 INFO - PROCESS | 1657 | |4;audio-oscillator;90;72;90;72;70;72;84;69;71;86 08:40:30 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;94;91;95;92;95;92;94;92;95;92 08:40:30 INFO - PROCESS | 1657 | |6;imaging-darkroom;97;99;100;100;99;105;99;99;100;100 08:40:30 INFO - PROCESS | 1657 | |7;imaging-desaturate;100;122;148;101;101;103;107;102;102;101 08:40:30 INFO - PROCESS | 1657 | |8;json-parse-financial;57;57;57;59;60;59;58;58;59;58 08:40:30 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;69;78;73;79;81;76;75;75;75;76 08:40:30 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;89;90;88;87;88;88;88;84;89;90 08:40:30 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;147;147;144;146;149;149;159;151;200;158 08:40:30 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;179;178;178;177;176;179;179;179;175;177 08:40:30 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;70;70;70;70;81;86;88;62;77;86 08:40:30 INFO - PROCESS | 1657 | __end_tp_report 08:40:30 INFO - PROCESS | 1657 | __start_cc_report 08:40:30 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,2230 08:40:30 INFO - PROCESS | 1657 | __end_cc_report 08:40:30 INFO - PROCESS | 1657 | __startTimestamp1485362430762__endTimestamp 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | ------- Summary: start ------- 08:40:30 INFO - PROCESS | 1657 | Number of tests: 14 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:128.40 Median:119.00 stddev:21.56 (18.1%) stddev-sans-first:22.39 08:40:30 INFO - PROCESS | 1657 | Values: 116.0 119.0 118.0 119.0 120.0 174.0 164.0 117.0 119.0 118.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:123.00 Median:121.50 stddev:13.66 (11.2%) stddev-sans-first:11.95 08:40:30 INFO - PROCESS | 1657 | Values: 145.0 114.0 113.0 147.0 118.0 111.0 125.0 114.0 131.0 112.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:213.00 Median:213.00 stddev:1.05 (0.5%) stddev-sans-first:0.83 08:40:30 INFO - PROCESS | 1657 | Values: 215.0 212.0 212.0 214.0 213.0 212.0 213.0 214.0 213.0 212.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:67.20 Median:61.50 stddev:11.43 (18.6%) stddev-sans-first:10.60 08:40:30 INFO - PROCESS | 1657 | Values: 83.0 61.0 61.0 90.0 62.0 59.0 61.0 60.0 76.0 59.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.00 stddev:8.75 (11.2%) stddev-sans-first:8.04 08:40:30 INFO - PROCESS | 1657 | Values: 90.0 72.0 90.0 72.0 70.0 72.0 84.0 69.0 71.0 86.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:94.00 stddev:1.55 (1.6%) stddev-sans-first:1.62 08:40:30 INFO - PROCESS | 1657 | Values: 94.0 91.0 95.0 92.0 95.0 92.0 94.0 92.0 95.0 92.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:99.80 Median:98.00 stddev:2.04 (2.1%) stddev-sans-first:1.90 08:40:30 INFO - PROCESS | 1657 | Values: 97.0 99.0 100.0 100.0 99.0 105.0 99.0 99.0 100.0 100.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:108.70 Median:102.50 stddev:15.28 (14.9%) stddev-sans-first:15.87 08:40:30 INFO - PROCESS | 1657 | Values: 100.0 122.0 148.0 101.0 101.0 103.0 107.0 102.0 102.0 101.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.50 stddev:1.03 (1.8%) stddev-sans-first:1.00 08:40:30 INFO - PROCESS | 1657 | Values: 57.0 57.0 57.0 59.0 60.0 59.0 58.0 58.0 59.0 58.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:76.00 stddev:3.30 (4.3%) stddev-sans-first:2.46 08:40:30 INFO - PROCESS | 1657 | Values: 69.0 78.0 73.0 79.0 81.0 76.0 75.0 75.0 75.0 76.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.50 stddev:1.73 (2.0%) stddev-sans-first:1.80 08:40:30 INFO - PROCESS | 1657 | Values: 89.0 90.0 88.0 87.0 88.0 88.0 88.0 84.0 89.0 90.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:155.00 Median:150.00 stddev:16.56 (11.0%) stddev-sans-first:17.31 08:40:30 INFO - PROCESS | 1657 | Values: 147.0 147.0 144.0 146.0 149.0 149.0 159.0 151.0 200.0 158.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:178.50 stddev:1.42 (0.8%) stddev-sans-first:1.42 08:40:30 INFO - PROCESS | 1657 | Values: 179.0 178.0 178.0 177.0 176.0 179.0 179.0 179.0 175.0 177.0 08:40:30 INFO - PROCESS | 1657 | 08:40:30 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:79.00 stddev:8.88 (11.2%) stddev-sans-first:9.15 08:40:30 INFO - PROCESS | 1657 | Values: 70.0 70.0 70.0 70.0 81.0 86.0 88.0 62.0 77.0 86.0 08:40:30 INFO - PROCESS | 1657 | -------- Summary: end -------- 08:40:30 INFO - PROCESS | 1657 | 08:40:31 INFO - TEST-INFO | 1657: exit 0 08:40:31 INFO - TEST-OK | kraken | took 61548ms 08:40:31 INFO - SUITE-END | took 1180s 08:40:31 INFO - Completed test suite (00:19:40) 08:40:31 INFO - javascript benchmark 08:40:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2881.078055022393, 2902.129361191642, 2915.1546051645023, 2982.5824384586163, 3004.7445967092794, 4973.154563724166, 5023.372078490189, 5044.697318160913, 5049.091163590552, 5107.846764597063, 5007.974960125194, 5037.118504261749, 5052.141136006879, 5060.51925067118, 5116.513931176532, 4626.930596041046, 4634.6755727099035, 4736.431628204603, 4750.738709370983, 4755.191617425029, 4545.9545404546025, 4559.065391594731, 4585.105904348653, 4722.244440889458, 4722.763861806913, 4671.719696818185, 4705.576498115169, 4716.268978308368, 4718.056388722252, 4732.0, 4584.839530616429, 4617.930731039037, 4625.606823419979, 4695.812167513295, 4701.130290896195, 4634.884127896796, 4637.397138372024, 4669.2062349400685, 4669.32294817253, 4693.788779504896, 4943.184374578191, 4957.702537847741, 5037.748112594356, 5054.519820617035, 5070.3915530136255, 5297.549708274802, 5354.625176237665, 5357.303550538444, 5458.5087342139395, 5549.944500554983, 5595.608307418483, 5610.523105536035, 5629.746661400247, 5649.548036157097, 5688.857778555528, 5213.843584692465, 5233.398159211663, 5235.136202526616, 5246.0, 5271.20931860224, 5516.420775818561, 5625.409332020161, 5640.8871822563315, 5739.225204597409, 5749.338826035059, 5319.654222475604, 5325.520703136659, 5350.51845333914, 5482.890342193134, 5506.862328441821, 5619.522340601013, 5622.0161471742285, 5626.606137570331, 5638.6052976292085, 5653.830385088454, 5492.286002819608, 5504.422035686275, 5515.7242137893745, 5518.2826232589505, 5551.639143455663, 5218.973905130526, 5348.732563371894, 5350.411454739976, 5479.424660410679, 5489.64317319373, 4405.493368262627, 4469.575390337913, 4470.329450582373, 4475.30632751924, 4534.02518458533, 3970.265500882346, 4001.6198461146146, 4003.2288926094143, 4007.957930937977, 4045.7370270932297, 4904.681195722266, 4922.950770492249, 4926.827561035347, 4937.481564435682, 4954.455009948902, 5234.241035049897, 5403.891922161535, 5437.374701909252, 5459.0, 5524.4199359067525, 4707.764611769398, 4785.952140478551, 4804.663673542888, 4894.926576101361, 4977.129002424634, 4893.535114164149, 4970.502949705001, 4972.90054198914, 4974.925376119361, 4975.4527002029745, 4826.372571565744, 5803.274590676166, 5819.82540523785, 5861.3552509223955, 5890.469857712741, 5356.116240820221, 5633.718314084362, 5643.012472817322, 5647.548196144381, 5654.773809047592, 5667.40492248308, 5703.315602127771, 5731.484166425042, 5759.107338362561, 5795.188673585617, 4925.753712314442, 5176.145935920531, 5531.474509921551, 5539.750711218086, 5565.7217139143695, 5545.946270208648, 5594.38461769197, 5604.355499117491, 5610.354809196994, 5612.382637909745, 4740.6444516660695, 5007.7746501408255, 5134.614903882149, 5255.947440525546, 5366.302380690485, 4419.270820314612, 5276.34045744282, 5359.651622644516, 5363.19552067193, 5377.354717433933, 5257.132573125545, 5273.920891186559, 5288.471152884681, 5297.2583838263445, 5327.866803329948, 5167.974160129325, 5255.579553635776, 5375.704336261543, 5375.731213439234, 5387.595930305164, 5136.409312928911, 5195.5583775378, 5212.609054321017, 5280.128778751617, 5297.735113244245], "value": 5050.003111734435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.2495321272614, 423.86648205815175, 441.955804419558, 449.9572540608641, 476.80212711724636, 25514.234572962818, 39602.80198599007, 41536.58463415365, 41622.58377416229, 41929.79035104828, 42510.78744606273, 42934.141317173635, 42945.57054429455, 42955.57044429555, 42973.78513107438, 9064.546772661373, 9276.165145136936, 9292.303077269198, 9300.674476393327, 9315.161635452809, 8191.549464779435, 8441.788955276106, 10965.287256328313, 11231.494582743797, 11263.887361126406, 11238.831417528743, 11293.943530282337, 11313.321200727942, 11316.773664526705, 11325.207235493519, 10804.297720648132, 11099.001089901907, 11142.832857507063, 11197.328160310408, 11237.21339506239, 8139.4709343892455, 8377.329813614897, 10737.892621073768, 10983.890161098367, 11023.228374013823, 40436.0, 40912.38631420531, 40945.79527102375, 40970.590294096975, 41022.38466423006, 3904.7852368119743, 3921.215756848613, 3942.546607140187, 3969.4442778011103, 3970.06703424695, 26980.730192698018, 27739.861300693367, 27936.58095128575, 28112.016079437326, 29258.853705731548, 3087.3825234952874, 3094.149108995022, 3135.843207839599, 3180.5547223388744, 3187.6493585705553, 457262.0, 457699.9999999967, 460171.0, 461595.0, 461818.0, 56747.43252567504, 57145.14282285769, 57199.714001429726, 57394.426055738906, 57492.97549171518, 59468.40531594715, 59486.70256648689, 59525.70237148873, 59564.80870382568, 59645.70177149173, 15284.770728439082, 15756.92121539385, 15766.9211653941, 15791.36834526606, 15804.36782528709, 11924.821127683092, 12197.634070977885, 12288.815667764991, 12313.56902508408, 12321.260724356567, 15273.159976201194, 15652.217389130497, 15702.842971570139, 17350.56623584395, 17846.732299015526, 6608.2730899601, 7601.315881570686, 7769.251918318333, 7855.371570274365, 7864.84270314602, 733.1422235983912, 770.5107256891802, 774.8334108166771, 777.2654841175148, 790.083503136359, 25591.976320946953, 28858.134255972356, 29244.415111697646, 29630.40739185204, 29736.650691005452, 998.510729742421, 1001.4341896828269, 1011.8482227665909, 1012.4735137728487, 1132.694172573417, 14900.925495372454, 15383.38466461329, 15467.690646187239, 15717.764233536505, 15787.28957196929, 609594.0, 610583.0, 616943.9152804296, 620271.8986405039, 620627.0, 61117.694411528544, 61168.0, 61200.0, 61321.0, 61788.69105654533, 1199.9200719352305, 1335.599320203935, 1355.830521184852, 1375.532319011521, 1379.620604333796, 27958.3010424741, 28913.132606021853, 28923.987660431783, 29102.56346154767, 29704.25739356447, 51449.742751286, 51495.45513634597, 51701.741491292305, 51753.482465174864, 51798.0, 501760.0, 503492.0, 504949.0, 506423.0, 507673.0, 26164.476710466064, 26545.867270663523, 26582.936682533254, 26610.06864759724, 26624.0, 37433.62566374301, 43347.56652433561, 46218.53781462142, 49644.25533616926, 50094.74952625213, 38712.41931371088, 38800.41799372955, 39210.2157956845, 39376.0, 40637.79681101575, 38378.808105959295, 38652.8404147876, 38777.61222387853, 40144.795656130365, 40151.0, 36792.0, 37228.0, 37814.62185378111, 37815.62184378121, 38051.80974095112, 32748.345033099682, 33804.66195338113, 34407.31185376229, 34604.65395346115, 34795.0, 24549.38626534351, 24664.506709866062, 24800.627990579796, 25108.372290692878, 25276.873615631805], "value": 19608.486553984996, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.19035920490546, 336.725568661541, 354.9645035496449, 370.7164019525064, 389.55590626685586, 13800.930995345021, 14434.566962991114, 15179.2410379481, 20252.493687657818, 20732.0, 20047.398578042645, 20627.38117856463, 20743.688844667344, 21023.47441313968, 21497.0, 5513.393526712059, 5854.736536855852, 5870.383609720981, 5881.117832325164, 5901.4688678018965, 4782.545658162469, 5768.682722450264, 5823.767049318022, 5826.912596311037, 5830.154627578999, 5716.857078573027, 5775.826725198251, 5783.0, 5791.407362975195, 5799.652020878761, 5560.443955604427, 5864.882702345951, 5919.467247947706, 5965.642061476282, 5972.432618901197, 5647.661140331593, 5768.538516918678, 5828.6211396259105, 5864.091065884794, 5883.029300165467, 13201.933990329986, 13403.530876419376, 13409.396577153953, 13441.462341506329, 21489.140434382763, 2541.8474891506567, 2555.821092523524, 2558.398776287571, 2576.6779152605923, 2673.719259477746, 9846.064623860722, 10162.524756909574, 14012.719745605133, 15078.773818392732, 15829.525114246591, 1785.9464216073538, 1799.3522331960485, 1834.871558990871, 1837.9448616541524, 1844.1516902224992, 118090.0, 132441.0, 133399.0, 137014.60313652566, 138879.0, 11295.943520282346, 11380.317180969168, 11438.885611143949, 11466.54133834654, 11604.303741775351, 14636.121832690073, 14994.850051499345, 15151.318190681446, 15193.772093418607, 15268.770968435483, 7559.5464272143845, 8466.703665371806, 8479.915200848036, 8582.313414926792, 8583.0, 8422.578871056423, 8428.915710842935, 8454.66181352739, 8550.914490855012, 8574.742757717278, 4659.627229821606, 4668.276417155346, 4679.368285281444, 4687.695299805502, 4772.856814295507, 1906.7044608085769, 1963.4306051245264, 1969.960600788005, 1970.615729932678, 1975.1506852053467, 722.512304194677, 771.1440301265591, 773.9264769846856, 780.679921232292, 798.6645608844183, 20632.381028569165, 21531.461713456974, 21579.89210053971, 21582.676259856114, 21640.458988525097, 821.4947807098591, 831.5343407691712, 836.2181360428019, 854.5684429363132, 858.6908712863365, 9283.860742088875, 10251.897481025244, 11076.224664273584, 11315.094792416752, 11500.367479788692, 395454.0, 549828.0, 681304.0, 684699.0, 714516.0, 133291.3335433336, 140679.0, 140927.0, 142007.37926317184, 142317.5768242325, 914.4604683236922, 917.8026724254318, 946.3044662173435, 951.6336210558846, 951.8286708392556, 18620.906895465978, 18996.335128270443, 19253.90373048126, 19263.614727705088, 19264.90367548153, 52568.0, 54192.45807541874, 54315.0, 55225.72387138199, 57246.42753572578, 74241.25758742343, 74537.39119131022, 76826.61586692031, 77240.0, 77708.8343674834, 6985.511014228955, 7838.64726087316, 7882.9605851972665, 7984.720534781255, 8168.754937351889, 7797.493162944391, 11956.103292252941, 12416.0, 12485.0, 12729.172603780724, 10555.89444105549, 10580.576776928836, 10588.10001149911, 10716.089132423831, 10920.617778377718, 10507.31702439339, 10637.255392122786, 10686.465676715978, 10699.94650026745, 10887.020168184901, 10822.837657435302, 10835.51240194209, 10926.0, 11029.944850276019, 11166.497507612014, 8029.7189598363775, 8086.029676438865, 8092.959535202286, 8213.835723285381, 8224.38317126206, 8218.21926916942, 10618.469076546296, 10650.786984260427, 10676.46617669129, 10742.140628749838], "value": 9362.289746988476, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.9435725392357, 1363.250212383189, 1370.5545697648263, 1388.2364699415323, 1392.7632302508573, 6344.3338449462835, 7058.576485410879, 7654.808629784258, 7990.760277191686, 8217.972753405824, 8085.029796424437, 8098.149694282104, 8120.147384524628, 8170.305524030449, 8170.509769413825, 1946.6301402733436, 2212.8008479236864, 2251.223327951854, 2255.740589832166, 2259.8418110732255, 2054.0, 2160.5138843760187, 2247.4830788918557, 2255.560165767676, 2272.5682120397073, 2207.073029327686, 2213.0, 2220.85564438311, 2220.955580888381, 2222.422170235742, 2149.161826887515, 2175.7171567696255, 2182.3562049195525, 2186.0709198590694, 2195.736511618608, 2167.2522979572022, 2172.9565408691897, 2246.8876556172127, 2251.2683377902085, 2254.537819746948, 8144.877826832543, 8186.426950113494, 8193.959030204871, 8205.876911846268, 8210.794730131734, 4869.951300486985, 4970.229614409736, 5038.96701176258, 5050.823221187241, 5051.848444546669, 3207.903762887117, 3326.750493712957, 3349.464085746269, 3387.796732196076, 3448.0173150652195, 1129.5877004893237, 1170.5083864776814, 1180.9527618895233, 1201.0151675625991, 1227.3495047624774, 10432.061114499731, 10450.843237351522, 10469.0, 10490.947545262301, 10492.055714985689, 4191.266528357525, 4381.539938306496, 4422.336649502536, 4574.565416285448, 4603.263477843529, 8406.327493800482, 8474.830503389898, 8478.74563763088, 8481.660733570712, 8489.533075680773, 4947.282644016669, 4953.0, 4953.00939812039, 4954.157793175169, 4959.454460009396, 4166.145940082337, 4528.682992190581, 4610.4467463903875, 4616.0998605272325, 4620.815167393266, 2964.540496223046, 3326.900192994214, 3492.9695739756835, 3606.8016259105475, 3616.023673608111, 1080.5515710979855, 1111.698783518126, 1123.2586492914636, 1123.9831402528969, 1128.7121783945042, 799.5282783157849, 803.6423791412765, 815.4821688228018, 819.7909533069029, 825.8513467575895, 5308.601854860901, 5456.781728730885, 5633.408492108351, 5724.713764311768, 5788.102844059177, 829.4649950781833, 871.899731530882, 872.7294538693026, 876.8509353409936, 882.52343734384, 3578.6779189873037, 3589.5692516897616, 3622.42041273395, 3700.4634328022285, 3737.4954381158195, 9195.862062069074, 9277.443353398818, 9539.427634341962, 9719.319647624598, 9740.220782337396, 9588.76028099303, 9721.9027809721, 9732.2214222862, 9748.830140383057, 9753.512324383752, 7189.676464559107, 7505.924940750632, 7545.849083018309, 7554.017977662978, 7620.657070431844, 5237.580993520585, 5314.681119132864, 5423.864403389947, 5543.667379957215, 5851.678157701197, 8861.955690221508, 8944.910550894409, 8986.460812351279, 9038.231750301298, 9084.091590840862, 8658.307335413027, 9072.727818165466, 9181.081891810765, 9258.72223833286, 9297.116773906468, 6804.21751498584, 7118.25258347866, 7120.216776154515, 7121.857562848818, 7129.322714342129, 7102.502824802421, 7224.458165637493, 7297.489175757646, 7718.189590092959, 7794.103678077094, 6938.202106757585, 6950.478714096362, 6953.478489113236, 7134.036905017963, 7137.607431591312, 6780.118584583973, 6819.454443644596, 6827.112475378169, 6849.31506849331, 6857.348551887762, 6165.815025549241, 6168.568200225941, 6230.6884655766125, 6253.530985176039, 6256.343083976299, 4262.46719160105, 4701.788419521198, 4792.688475249237, 4910.975445122752, 4942.802287908444, 4251.511076226274, 4759.690620109682, 4834.7824347903725, 4879.829205977774, 4955.1823949048], "value": 4229.384143906385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.5240218275861, 320.5464268060694, 330.60657817197534, 334.0679504183329, 335.6777493606138, 3862.497875276217, 4172.0, 4235.597618226271, 4246.660267178626, 4274.679399045072, 3838.694843753123, 3983.6813054955605, 4029.3351596986536, 4050.574689657588, 4157.501099868013, 2844.904711685995, 2954.739624187498, 3319.937619961613, 3337.699607035366, 3380.951904909474, 3371.73026157908, 3379.3241351729753, 3408.84660190292, 3409.267007593367, 3455.118944669106, 3139.571494969783, 3367.0, 3402.6767457091537, 3434.965650343502, 3437.5390459054925, 2714.674239091302, 2867.7562407195414, 3257.6579459156683, 3377.307651931348, 3401.727861771065, 3017.5624534442604, 3020.3506246156962, 3050.8339079253756, 3058.29659178388, 3083.861226244802, 3990.940135897964, 4016.3373043447796, 4026.2148880968225, 4032.5362583303004, 4058.6955978301744, 3703.092742278132, 3799.3351163546545, 3809.657130858236, 3845.692344612424, 3845.9230815383817, 3845.61543845616, 3923.784191869446, 4450.599446049871, 4460.219461594241, 4488.663350248712, 3371.5448414463976, 3377.746668999835, 3382.004617275819, 3382.410267174424, 3385.339858727549, 4477.925297928507, 4534.274516077412, 4612.423447069116, 4622.329762184464, 4666.673332866701, 3302.53764472974, 3394.710010196159, 3413.4367829307885, 3416.4533674611944, 3428.8285585720614, 3485.2506711057245, 3488.284901595167, 3491.8952431427097, 3494.056604716712, 3500.899460323785, 3405.1316914186723, 3516.40221162403, 3851.5955824638568, 3874.6900247980093, 3905.0042239228815, 3813.427985802152, 4158.897892058607, 4526.072155208174, 4546.772661366985, 4560.931586026146, 979.8775153105862, 1058.9046985771317, 1112.5425692343056, 1119.0152665654334, 1144.856892888389, 712.5297303779481, 761.584936209767, 782.5383024015858, 807.7495976247382, 818.7339114787718, 3278.7868788528667, 3290.9431605246723, 3578.6600272974024, 3688.907777305535, 3905.500479692999, 3787.981060094737, 4365.432493775852, 4500.257457519473, 4515.9774201128785, 4525.932111018337, 3473.565804274466, 3707.573629032696, 3714.9598112528533, 4022.416749571354, 4032.3749818778138, 1904.9428517144509, 2030.6852437872153, 2191.6931629571873, 2205.558888222362, 2206.9227577034726, 4396.054848207651, 4397.31841564558, 4397.648188144941, 4408.691391602557, 4458.509563947963, 3992.48097747291, 4027.677785777131, 4359.673024523174, 4380.934285985712, 4432.894375171768, 4101.630853223224, 4228.9154216915485, 4283.5502272260965, 4397.868063958151, 4583.610393116555, 3858.401947698111, 4495.100979803987, 4582.564656357641, 4583.564561366665, 4642.37327960721, 4344.978929951522, 4564.680472366902, 4584.4498660161, 4586.610138138296, 4587.24310488779, 4375.606195442426, 4716.457607375059, 4747.738874361943, 4784.330193772944, 4784.497627749175, 2770.944581108326, 2952.586637870657, 3234.649396561621, 3235.8350993641798, 3266.8693252269645, 3823.9617603823604, 4075.5720649331392, 4540.502723501994, 4548.135854187693, 4584.656150788637, 4332.465507677917, 4471.552844715502, 4491.360653361565, 4493.73037617744, 4541.707262234853, 4302.139572085658, 4442.955570444384, 4507.977460112678, 4516.728996260234, 4520.073384956142, 3918.4710064140977, 4068.9420750604463, 4407.537208593051, 4452.62905737212, 4481.521098037574, 4018.7186896916937, 4127.938080928849, 4444.222261104358, 4460.553944605514, 4475.7985890634345, 3581.4985901974264, 4134.834606615702, 4278.465191851019, 4376.606105450524, 4391.912161756811], "value": 3319.5910589729433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.4141297071549, 686.9072675188851, 745.9552426854389, 787.2993036197784, 795.2484901767829, 14548.854511454896, 15614.063156210606, 15633.296501657424, 15637.296321665524, 15653.0, 13903.374348154332, 13963.301834908265, 14150.363233654485, 14312.998090133695, 14379.928100359484, 712.2450202785064, 810.1776696652902, 842.1704620948361, 842.3892677808601, 842.4355681693249, 832.8917240758693, 839.0518713853368, 839.7564706235215, 840.2060053249681, 840.2437805974611, 883.8276536075468, 884.3014018925041, 884.747846863644, 884.7743825324533, 886.8847049883539, 860.5783166248556, 883.924866386358, 884.3809333466567, 884.4118661090367, 889.5596679643553, 657.5364368120463, 657.539722194461, 657.8486948001938, 658.9835254118638, 666.1207206487438, 13244.933775331157, 14460.710785784331, 14968.101913885093, 15121.092734435859, 15482.5355239343, 13614.047016708835, 13726.93136534321, 13789.724205515933, 13908.860911390959, 13954.93022534891, 11170.0, 11194.776104477865, 11213.215074944757, 11584.42077896102, 11758.353290569015, 3604.53141091659, 3632.7275454340765, 3643.890683279506, 3709.4806727058235, 3754.0, 79817.0, 100439.0, 102080.0, 103056.0, 104460.95539044589, 9913.355631883904, 10344.896551034393, 10350.844737328945, 10697.946510267398, 10768.730781730363, 20241.898790505955, 21852.907354632203, 21878.89060554719, 21896.233631822808, 21919.232826850985, 7558.357539609195, 7619.580923049175, 7627.923720762832, 7645.541267523855, 7809.336206422404, 4182.2681030819485, 4193.098483825992, 4268.957310426856, 4310.698251122391, 4442.222611043055, 3512.648735126467, 3541.8229088545468, 3557.8043207623314, 3617.909552261162, 3622.873199438007, 648.2868844271264, 649.4187702006677, 650.2554575011679, 652.8335274505066, 660.1912656995142, 501.34073693093467, 619.5136817598163, 626.8495561065312, 641.3169973977699, 644.365300179323, 9251.444913305224, 10017.08703427856, 10031.949840250752, 10265.281430299956, 10487.685369438928, 618.9972244963099, 632.6552029144127, 635.5582869905371, 643.3020173112133, 643.9420452159235, 4908.509149085135, 4957.752112394366, 4961.751912404366, 4963.503649635008, 4971.502849715, 100795.99204007867, 101557.0, 102517.97482025085, 104100.0, 104766.0, 84429.15570844336, 85667.0, 87832.5608371954, 88049.55975220083, 88980.11019889847, 76735.46529069387, 78170.0, 79159.60420197978, 79681.0, 79716.0, 8195.590220489072, 9465.621375145192, 9542.904570954202, 9583.424994500352, 9654.2276617869, 39748.80125599354, 49298.014039718284, 49922.75038624783, 50423.45147662564, 51797.482025180776, 49782.75108624434, 66669.0, 67006.0, 68304.63390732057, 69745.30254697388, 10874.67375978722, 11241.044511216638, 11270.661880143609, 11456.891547975281, 11489.138314626269, 12149.75700486003, 12225.87774122283, 12401.565945191875, 12457.0, 12711.872881271438, 11239.325640461271, 11386.94306528462, 11393.487293071666, 12022.819657704966, 12379.071569632133, 11636.0, 11721.179517433698, 11722.824157637813, 12015.75968480608, 12058.216215945935, 11581.131415144066, 11773.705657358634, 11784.941075294568, 12146.08904332161, 12307.26156430617, 9182.724518264462, 9373.953130234306, 9559.61761529531, 9771.169450596779, 9797.902020979984, 7898.973133492609, 8477.448965817202, 9130.178283954476, 9207.956312034292, 9382.249420046244], "value": 7161.023970046605, "unit": "score"}], "name": "dromaeo_css", "value": 6733.6838813435, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 118.0, 119.0, 120.0, 174.0, 164.0, 117.0, 119.0, 118.0], "value": 128.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 113.0, 147.0, 118.0, 111.0, 125.0, 114.0, 131.0, 112.0], "value": 123.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 212.0, 212.0, 214.0, 213.0, 212.0, 213.0, 214.0, 213.0, 212.0], "value": 213.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 61.0, 90.0, 62.0, 59.0, 61.0, 60.0, 76.0, 59.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 90.0, 72.0, 70.0, 72.0, 84.0, 69.0, 71.0, 86.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 91.0, 95.0, 92.0, 95.0, 92.0, 94.0, 92.0, 95.0, 92.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 99.0, 100.0, 100.0, 99.0, 105.0, 99.0, 99.0, 100.0, 100.0], "value": 99.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 122.0, 148.0, 101.0, 101.0, 103.0, 107.0, 102.0, 102.0, 101.0], "value": 108.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 59.0, 60.0, 59.0, 58.0, 58.0, 59.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 73.0, 79.0, 81.0, 76.0, 75.0, 75.0, 75.0, 76.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 88.0, 87.0, 88.0, 88.0, 88.0, 84.0, 89.0, 90.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 144.0, 146.0, 149.0, 149.0, 159.0, 151.0, 200.0, 158.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 178.0, 177.0, 176.0, 179.0, 179.0, 179.0, 175.0, 177.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 81.0, 86.0, 88.0, 62.0, 77.0, 86.0], "value": 76.0, "unit": "score"}], "name": "kraken", "value": 1541.6000000000001, "alertThreshold": 2.0}]} 08:40:31 INFO - Return code: 0 08:40:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:40:32 ERROR - # TBPL SUCCESS # 08:40:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:40:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:40:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:40:32 INFO - 2017-01-25 08:40:32.045 screenresolution[1662:10992] starting screenresolution argv=screenresolution get 08:40:32 INFO - 2017-01-25 08:40:32.050 screenresolution[1662:10992] Display 0: 1600x1200x32@60 08:40:32 INFO - 2017-01-25 08:40:32.056 screenresolution[1663:10994] starting screenresolution argv=screenresolution list 08:40:32 INFO - Available Modes on Display 0 08:40:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:40:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:40:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:40:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:40:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:40:32 INFO - Intel Iris: 08:40:32 INFO - Chipset Model: Intel Iris 08:40:32 INFO - Type: GPU 08:40:32 INFO - Bus: Built-In 08:40:32 INFO - VRAM (Dynamic, Max): 1536 MB 08:40:32 INFO - Vendor: Intel (0x8086) 08:40:32 INFO - Device ID: 0x0a2e 08:40:32 INFO - Revision ID: 0x0009 08:40:32 INFO - Displays: 08:40:32 INFO - Display: 08:40:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:40:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:40:32 INFO - Display Serial Number: 1600x1200 60 08:40:32 INFO - Main Display: Yes 08:40:32 INFO - Mirror: Off 08:40:32 INFO - Online: Yes 08:40:32 INFO - Rotation: Supported 08:40:32 INFO - Return code: 0 08:40:32 INFO - Running post-action listener: _resource_record_post_action 08:40:32 INFO - [mozharness: 2017-01-25 16:40:32.314328Z] Finished run-tests step (success) 08:40:32 INFO - Running post-run listener: _resource_record_post_run 08:40:32 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32726016; Write bytes: 508443648; Read time: 307; Write time: 1536 08:40:32 INFO - TinderboxPrint: CPU usage
53.9% 08:40:32 INFO - TinderboxPrint: I/O read bytes / time
32,726,016 / 307 08:40:32 INFO - TinderboxPrint: I/O write bytes / time
508,443,648 / 1,536 08:40:32 INFO - TinderboxPrint: CPU idle
2,215.5 (46.1%) 08:40:32 INFO - TinderboxPrint: CPU system
970.5 (20.2%) 08:40:32 INFO - TinderboxPrint: CPU user
1,623.7 (33.8%) 08:40:32 INFO - TinderboxPrint: Swap in / out
235,663,360 / 0 08:40:32 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 203160064; Write bytes: 201394176; Read time: 16365; Write time: 427 08:40:32 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 30764032; Write bytes: 296297472; Read time: 287; Write time: 1074 08:40:32 INFO - Running post-run listener: _upload_blobber_files 08:40:32 INFO - Blob upload gear active. 08:40:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:40:32 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 08:40:32 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'] 08:40:32 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 08:40:33 INFO - (blobuploader) - INFO - Open directory for files ... 08:40:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:40:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:40:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:34 INFO - (blobuploader) - INFO - Done attempting. 08:40:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:40:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:40:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:35 INFO - (blobuploader) - INFO - Done attempting. 08:40:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:40:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:40:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:36 INFO - (blobuploader) - INFO - Done attempting. 08:40:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:40:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:40:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:38 INFO - (blobuploader) - INFO - Done attempting. 08:40:38 INFO - (blobuploader) - INFO - Iteration through files over. 08:40:38 INFO - Return code: 0 08:40:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:40:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:40:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96ce62304e1b04ae528b4074986d69daf80613574f491042966aa48dbc0bf06944d876733b51e8ed2e48c3aeef89f44e47a39f1bfd8241c9a13ad8ebe2c017e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0da4351f037dfa9d9cb9deb5689844875e4eddf042d695d9ad8f745f69f17b975ff5e04c2ea3c24350db304e92e1601163d27e036aac83275e49aa2ef1befba4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8be3c0fa0d58fc639d6dfa643ed4730ee872a7aedf07a22de93caa0439a9d47b17ddfc3e494453a8c2f4fd8339fa7586b61d2d16435eadc58e58902bc8c96d4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63378c5576f4bd18a4e380498e59e0bd36711634cef3ed4d26fba2ba7c35e10bc9328c269601cea3da8573e99699e5125bcb4fa56b69826ae3191778200bbd94"} 08:40:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:40:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:40:38 INFO - Contents: 08:40:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96ce62304e1b04ae528b4074986d69daf80613574f491042966aa48dbc0bf06944d876733b51e8ed2e48c3aeef89f44e47a39f1bfd8241c9a13ad8ebe2c017e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0da4351f037dfa9d9cb9deb5689844875e4eddf042d695d9ad8f745f69f17b975ff5e04c2ea3c24350db304e92e1601163d27e036aac83275e49aa2ef1befba4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8be3c0fa0d58fc639d6dfa643ed4730ee872a7aedf07a22de93caa0439a9d47b17ddfc3e494453a8c2f4fd8339fa7586b61d2d16435eadc58e58902bc8c96d4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63378c5576f4bd18a4e380498e59e0bd36711634cef3ed4d26fba2ba7c35e10bc9328c269601cea3da8573e99699e5125bcb4fa56b69826ae3191778200bbd94"} 08:40:38 INFO - Running post-run listener: copy_logs_to_upload_dir 08:40:38 INFO - Copying logs to upload dir... 08:40:38 INFO - mkdir: /builds/slave/test/build/upload/logs 08:40:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.480828 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-25 08:40:38.451520) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 08:40:38.455303) ========= 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.cfmHsolFPV/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.VEOa1yKokA/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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/96ce62304e1b04ae528b4074986d69daf80613574f491042966aa48dbc0bf06944d876733b51e8ed2e48c3aeef89f44e47a39f1bfd8241c9a13ad8ebe2c017e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0da4351f037dfa9d9cb9deb5689844875e4eddf042d695d9ad8f745f69f17b975ff5e04c2ea3c24350db304e92e1601163d27e036aac83275e49aa2ef1befba4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8be3c0fa0d58fc639d6dfa643ed4730ee872a7aedf07a22de93caa0439a9d47b17ddfc3e494453a8c2f4fd8339fa7586b61d2d16435eadc58e58902bc8c96d4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63378c5576f4bd18a4e380498e59e0bd36711634cef3ed4d26fba2ba7c35e10bc9328c269601cea3da8573e99699e5125bcb4fa56b69826ae3191778200bbd94"} build_url:https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.012100 build_url: 'https://queue.taskcluster.net/v1/task/Wax0IPvbSBOmzf5WgbKAsg/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/96ce62304e1b04ae528b4074986d69daf80613574f491042966aa48dbc0bf06944d876733b51e8ed2e48c3aeef89f44e47a39f1bfd8241c9a13ad8ebe2c017e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0da4351f037dfa9d9cb9deb5689844875e4eddf042d695d9ad8f745f69f17b975ff5e04c2ea3c24350db304e92e1601163d27e036aac83275e49aa2ef1befba4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8be3c0fa0d58fc639d6dfa643ed4730ee872a7aedf07a22de93caa0439a9d47b17ddfc3e494453a8c2f4fd8339fa7586b61d2d16435eadc58e58902bc8c96d4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63378c5576f4bd18a4e380498e59e0bd36711634cef3ed4d26fba2ba7c35e10bc9328c269601cea3da8573e99699e5125bcb4fa56b69826ae3191778200bbd94"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 08:40:38.495652) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 08:40:38.496194) ========= 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.cfmHsolFPV/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.VEOa1yKokA/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.005589 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 08:40:38.547579) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 08:40:38.548398) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 08:40:38.549193) ========= ========= Total master_lag: 1.15 =========