builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0281 starttime: 1477325177.49 results: success (0) buildid: 20161024063222 builduid: 0c28c0dcee834a6bbdf42eb800766022 revision: 0997fc0a73e859e7ed7c9d9765dcf96dbe9e4b95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:17.491762) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:17.492294) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:17.492618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:17.516591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:17.516984) ========= 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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-24 09:06:17-- 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% 25.4M=0s 2016-10-24 09:06:17 (25.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.402021 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:17.941181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:17.941718) ========= 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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.024138 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:17.989840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-24 09:06:17.990197) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0997fc0a73e859e7ed7c9d9765dcf96dbe9e4b95 --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 0997fc0a73e859e7ed7c9d9765dcf96dbe9e4b95 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lGfzlOHHMO/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.gWtCgo0xmF/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-24 09:06:18,070 truncating revision to first 12 chars 2016-10-24 09:06:18,070 Setting DEBUG logging. 2016-10-24 09:06:18,070 attempt 1/10 2016-10-24 09:06:18,070 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0997fc0a73e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 09:06:19,151 unpacking tar archive at: mozilla-aurora-0997fc0a73e8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.079087 ========= master_lag: 1.57 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-24 09:06:21.637095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:21.637388) ========= script_repo_revision: 0997fc0a73e859e7ed7c9d9765dcf96dbe9e4b95 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:21.637806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:21.638099) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 09:06:21.664954) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-24 09:06:21.665332) ========= /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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:06:21 INFO - MultiFileLogger online at 20161024 09:06:21 in /builds/slave/test 09:06:21 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 09:06:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:06:21 INFO - {'append_to_log': False, 09:06:21 INFO - 'base_work_dir': '/builds/slave/test', 09:06:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:06:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:06:21 INFO - 'branch': 'Mozilla-Aurora', 09:06:21 INFO - 'buildbot_json_path': 'buildprops.json', 09:06:21 INFO - 'config_files': ('talos/mac_config.py',), 09:06:21 INFO - 'default_actions': ('clobber', 09:06:21 INFO - 'read-buildbot-config', 09:06:21 INFO - 'download-and-extract', 09:06:21 INFO - 'populate-webroot', 09:06:21 INFO - 'create-virtualenv', 09:06:21 INFO - 'install', 09:06:21 INFO - 'run-tests'), 09:06:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:06:21 INFO - 'download_minidump_stackwalk': True, 09:06:21 INFO - 'download_symbols': 'ondemand', 09:06:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:06:21 INFO - 'tooltool.py': '/tools/tooltool.py', 09:06:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:06:21 INFO - '/tools/misc-python/virtualenv.py')}, 09:06:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:06:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:06:21 INFO - 'installer_path': 'installer.exe', 09:06:21 INFO - 'log_level': 'info', 09:06:21 INFO - 'log_name': 'talos', 09:06:21 INFO - 'log_to_console': True, 09:06:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:06:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:06:21 INFO - 'opt_config_files': (), 09:06:21 INFO - 'pip_index': False, 09:06:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:06:21 INFO - 'cmd': ('bash', 09:06:21 INFO - '-c', 09:06:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:06:21 INFO - 'enabled': True, 09:06:21 INFO - 'halt_on_failure': False, 09:06:21 INFO - 'name': 'check_screen_resolution'},), 09:06:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:06:21 INFO - 'cmd': ('bash', 09:06:21 INFO - '-c', 09:06:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:06:21 INFO - 'enabled': True, 09:06:21 INFO - 'halt_on_failure': False, 09:06:21 INFO - 'name': 'check_screen_resolution'},), 09:06:21 INFO - 'run_cmd_checks_enabled': True, 09:06:21 INFO - 'sps_profile': False, 09:06:21 INFO - 'sps_profile_interval': 0, 09:06:21 INFO - 'suite': 'dromaeojs', 09:06:21 INFO - 'system_bits': '32', 09:06:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:06:21 INFO - 'title': 't-yosemite-r7-0281', 09:06:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:06:21 INFO - 'use_talos_json': True, 09:06:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:06:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:06:21 INFO - 'work_dir': 'build'} 09:06:21 INFO - [mozharness: 2016-10-24 16:06:21.861000Z] Running clobber step. 09:06:21 INFO - Running pre-action listener: _resource_record_pre_action 09:06:21 INFO - Running main action method: clobber 09:06:21 INFO - rmtree: /builds/slave/test/build 09:06:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:06:23 INFO - Running post-action listener: _resource_record_post_action 09:06:23 INFO - [mozharness: 2016-10-24 16:06:23.939928Z] Finished clobber step (success) 09:06:23 INFO - [mozharness: 2016-10-24 16:06:23.940180Z] Running read-buildbot-config step. 09:06:23 INFO - Running pre-action listener: _resource_record_pre_action 09:06:23 INFO - Running main action method: read_buildbot_config 09:06:23 INFO - Using buildbot properties: 09:06:23 INFO - { 09:06:23 INFO - "project": "", 09:06:23 INFO - "product": "firefox", 09:06:23 INFO - "script_repo_revision": "production", 09:06:23 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:06:23 INFO - "repository": "", 09:06:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:06:23 INFO - "buildid": "20161024063222", 09:06:23 INFO - "pgo_build": "False", 09:06:23 INFO - "basedir": "/builds/slave/test", 09:06:23 INFO - "buildnumber": 17, 09:06:23 INFO - "slavename": "t-yosemite-r7-0281", 09:06:23 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:06:23 INFO - "platform": "yosemite_r7", 09:06:23 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:06:23 INFO - "branch": "mozilla-aurora", 09:06:23 INFO - "repo_path": "releases/mozilla-aurora", 09:06:23 INFO - "revision": "0997fc0a73e859e7ed7c9d9765dcf96dbe9e4b95", 09:06:23 INFO - "stage_platform": "macosx64", 09:06:23 INFO - "builduid": "0c28c0dcee834a6bbdf42eb800766022", 09:06:23 INFO - "slavebuilddir": "test" 09:06:23 INFO - } 09:06:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 09:06:23 INFO - Running post-action listener: _resource_record_post_action 09:06:23 INFO - [mozharness: 2016-10-24 16:06:23.945853Z] Finished read-buildbot-config step (success) 09:06:23 INFO - [mozharness: 2016-10-24 16:06:23.946072Z] Running download-and-extract step. 09:06:23 INFO - Running pre-action listener: _resource_record_pre_action 09:06:23 INFO - Running main action method: download_and_extract 09:06:23 INFO - mkdir: /builds/slave/test/build/tests 09:06: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')]} 09:06:23 INFO - trying https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 09:06:23 INFO - Downloading https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:06:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 09:06:25 INFO - Downloaded 1199 bytes. 09:06:25 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:06:25 INFO - Using the following test package requirements: 09:06:25 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:06:25 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:06:25 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 09:06:25 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:06:25 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 09:06:25 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:06:25 INFO - u'jsshell-mac.zip'], 09:06:25 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:06:25 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 09:06:25 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:06:25 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:06:25 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 09:06:25 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:06:25 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 09:06:25 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:06:25 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 09:06:25 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:06:25 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 09:06:25 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:06:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:06:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:06:25 INFO - Fetch https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:06:26 INFO - Expected file size: 16438331 09:06:32 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:06:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:06:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:06:32 INFO - Fetch https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:06:33 INFO - Expected file size: 16438331 09:06:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 09:06:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:06:40 INFO - Fetch https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 09:06:40 INFO - Expected file size: 14414081 09:06:41 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')]} 09:06:41 INFO - trying https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:06:41 INFO - Downloading https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 09:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 09:06:44 INFO - Downloaded 115430824 bytes. 09:06:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:06:44 INFO - mkdir: /builds/slave/test/properties 09:06:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:06:44 INFO - Writing to file /builds/slave/test/properties/build_url 09:06:44 INFO - Contents: 09:06:44 INFO - build_url:https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:06:44 INFO - Running post-action listener: _resource_record_post_action 09:06:44 INFO - Running post-action listener: set_extra_try_arguments 09:06:44 INFO - [mozharness: 2016-10-24 16:06:44.926923Z] Finished download-and-extract step (success) 09:06:44 INFO - [mozharness: 2016-10-24 16:06:44.927040Z] Running populate-webroot step. 09:06:44 INFO - Running pre-action listener: _resource_record_pre_action 09:06:44 INFO - Running main action method: populate_webroot 09:06:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:44 INFO - '--tppagecycles', 09:06:44 INFO - '7'], 09:06:44 INFO - 'tests': ['tsvgm']}}, 09:06:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:06:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:06:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:06:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:06:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:06:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:06:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:44 INFO - 'talos_options': ['--disable-e10s'], 09:06:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:44 INFO - 'talos_options': ['--disable-e10s'], 09:06:44 INFO - 'tests': ['damp', 'tps']}, 09:06:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:44 INFO - 'tests': ['damp', 'tps']}, 09:06:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:06:44 INFO - 'tests': ['dromaeo_dom']}, 09:06:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:06:44 INFO - 'tests': ['basic_compositor_video']}, 09:06:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:06:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:06:44 INFO - 'tests': ['a11yr', 09:06:44 INFO - 'ts_paint', 09:06:44 INFO - 'tpaint', 09:06:44 INFO - 'sessionrestore', 09:06:44 INFO - 'sessionrestore_no_auto_restore', 09:06:44 INFO - 'tabpaint']}, 09:06:44 INFO - 'other-e10s': {'tests': ['a11yr', 09:06:44 INFO - 'ts_paint', 09:06:44 INFO - 'tpaint', 09:06:44 INFO - 'sessionrestore', 09:06:44 INFO - 'sessionrestore_no_auto_restore', 09:06:44 INFO - 'tabpaint']}, 09:06:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:06:44 INFO - 'ts_paint', 09:06:44 INFO - 'tpaint', 09:06:44 INFO - 'sessionrestore', 09:06:44 INFO - 'sessionrestore_no_auto_restore', 09:06:44 INFO - 'tabpaint']}, 09:06:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:06:44 INFO - 'ts_paint', 09:06:44 INFO - 'tpaint', 09:06:44 INFO - 'sessionrestore', 09:06:44 INFO - 'sessionrestore_no_auto_restore', 09:06:44 INFO - 'tabpaint']}, 09:06:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:06:44 INFO - 'tests': ['a11yr', 09:06:44 INFO - 'ts_paint', 09:06:44 INFO - 'tpaint', 09:06:44 INFO - 'sessionrestore', 09:06:44 INFO - 'sessionrestore_no_auto_restore', 09:06:44 INFO - 'tabpaint']}, 09:06:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:06:44 INFO - 'tests': ['a11yr', 09:06:44 INFO - 'ts_paint', 09:06:44 INFO - 'tpaint', 09:06:44 INFO - 'sessionrestore', 09:06:44 INFO - 'sessionrestore_no_auto_restore', 09:06:44 INFO - 'tabpaint']}, 09:06:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:06:44 INFO - 'tests': ['tsvgx', 09:06:44 INFO - 'tsvgr_opacity', 09:06:44 INFO - 'tart', 09:06:44 INFO - 'tscrollx', 09:06:44 INFO - 'cart']}, 09:06:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:06:44 INFO - 'tsvgr_opacity', 09:06:44 INFO - 'tart', 09:06:44 INFO - 'tscrollx', 09:06:44 INFO - 'cart']}, 09:06:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:44 INFO - 'talos_options': ['--disable-e10s'], 09:06:44 INFO - 'tests': ['tp5o']}, 09:06:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:44 INFO - 'tests': ['tp5o']}, 09:06:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:44 INFO - 'talos_options': ['--disable-e10s', 09:06:44 INFO - '--xperf_path', 09:06:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:44 INFO - 'tests': ['tp5n']}, 09:06:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:44 INFO - 'talos_options': ['--xperf_path', 09:06:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:44 INFO - 'tests': ['tp5n']}}, 09:06:44 INFO - 'talos.zip': {'path': '', 09:06:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:44 INFO - Running post-action listener: _resource_record_post_action 09:06:44 INFO - [mozharness: 2016-10-24 16:06:44.945833Z] Finished populate-webroot step (success) 09:06:44 INFO - [mozharness: 2016-10-24 16:06:44.945965Z] Running create-virtualenv step. 09:06:44 INFO - Running pre-action listener: _resource_record_pre_action 09:06:44 INFO - Running main action method: create_virtualenv 09:06:44 INFO - Creating virtualenv /builds/slave/test/build/venv 09:06:44 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 09:06:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:06:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:45 INFO - Using real prefix '/tools/python27' 09:06:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:06:45 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:48 INFO - Installing pip.................done. 09:06:48 INFO - Return code: 0 09:06:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:48 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 0x1100bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110035570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd38ad8b730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed3d30>, '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 0x10fd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fecbb20>, '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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:06:48 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 09:06:48 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 09:06:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGfzlOHHMO/Render', 09:06:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:48 INFO - 'HOME': '/Users/cltbld', 09:06:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:48 INFO - 'LOGNAME': 'cltbld', 09:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:48 INFO - 'MOZ_NO_REMOTE': '1', 09:06:48 INFO - 'NO_EM_RESTART': '1', 09:06:48 INFO - 'PAGER': '/bin/cat', 09:06:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:48 INFO - 'PWD': '/builds/slave/test', 09:06:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:48 INFO - 'SHELL': '/bin/bash', 09:06:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWtCgo0xmF/Listeners', 09:06:48 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:06:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:48 INFO - 'USER': 'cltbld', 09:06:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:48 INFO - 'XPC_FLAGS': '0x0', 09:06:48 INFO - 'XPC_SERVICE_NAME': '0', 09:06:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:48 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 09:06:48 INFO - Cleaning up... 09:06:48 INFO - Return code: 0 09:06:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:48 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 0x1100bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110035570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd38ad8b730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed3d30>, '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 0x10fd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fecbb20>, '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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:06:48 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 09:06:48 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 09:06:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGfzlOHHMO/Render', 09:06:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:48 INFO - 'HOME': '/Users/cltbld', 09:06:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:48 INFO - 'LOGNAME': 'cltbld', 09:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:48 INFO - 'MOZ_NO_REMOTE': '1', 09:06:48 INFO - 'NO_EM_RESTART': '1', 09:06:48 INFO - 'PAGER': '/bin/cat', 09:06:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:48 INFO - 'PWD': '/builds/slave/test', 09:06:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:48 INFO - 'SHELL': '/bin/bash', 09:06:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWtCgo0xmF/Listeners', 09:06:48 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:06:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:48 INFO - 'USER': 'cltbld', 09:06:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:48 INFO - 'XPC_FLAGS': '0x0', 09:06:48 INFO - 'XPC_SERVICE_NAME': '0', 09:06:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:49 INFO - Downloading/unpacking psutil>=3.1.1 09:06:49 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 09:06:49 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 09:06:49 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 09:06:49 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 09:06:49 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 09:06:49 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 09:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:52 INFO - Installing collected packages: psutil 09:06:52 INFO - Running setup.py install for psutil 09:06:52 INFO - building 'psutil._psutil_osx' extension 09:06:52 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 09:06:53 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 09:06:53 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 09:06:53 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 09:06:53 INFO - building 'psutil._psutil_posix' extension 09:06:53 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 09:06:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:06:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:06:53 INFO - ^ 09:06:53 INFO - 1 warning generated. 09:06:53 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 09:06:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:53 INFO - Successfully installed psutil 09:06:53 INFO - Cleaning up... 09:06:53 INFO - Return code: 0 09:06:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:53 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 0x1100bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110035570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd38ad8b730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed3d30>, '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 0x10fd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fecbb20>, '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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:06:53 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 09:06:53 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 09:06:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGfzlOHHMO/Render', 09:06:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:53 INFO - 'HOME': '/Users/cltbld', 09:06:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:53 INFO - 'LOGNAME': 'cltbld', 09:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:53 INFO - 'MOZ_NO_REMOTE': '1', 09:06:53 INFO - 'NO_EM_RESTART': '1', 09:06:53 INFO - 'PAGER': '/bin/cat', 09:06:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:53 INFO - 'PWD': '/builds/slave/test', 09:06:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:53 INFO - 'SHELL': '/bin/bash', 09:06:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWtCgo0xmF/Listeners', 09:06:53 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:06:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:53 INFO - 'USER': 'cltbld', 09:06:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:53 INFO - 'XPC_FLAGS': '0x0', 09:06:53 INFO - 'XPC_SERVICE_NAME': '0', 09:06:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:06:53 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 09:06:53 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 09:06:53 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 09:06:53 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 09:06:53 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 09:06:53 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 09:06:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:06:56 INFO - Installing collected packages: mozsystemmonitor 09:06:56 INFO - Running setup.py install for mozsystemmonitor 09:06:56 INFO - Successfully installed mozsystemmonitor 09:06:56 INFO - Cleaning up... 09:06:56 INFO - Return code: 0 09:06:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:56 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 0x1100bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110035570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd38ad8b730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed3d30>, '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 0x10fd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fecbb20>, '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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:06:56 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 09:06:56 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 09:06:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGfzlOHHMO/Render', 09:06:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:56 INFO - 'HOME': '/Users/cltbld', 09:06:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:56 INFO - 'LOGNAME': 'cltbld', 09:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:56 INFO - 'MOZ_NO_REMOTE': '1', 09:06:56 INFO - 'NO_EM_RESTART': '1', 09:06:56 INFO - 'PAGER': '/bin/cat', 09:06:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:56 INFO - 'PWD': '/builds/slave/test', 09:06:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:56 INFO - 'SHELL': '/bin/bash', 09:06:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWtCgo0xmF/Listeners', 09:06:56 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:06:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:56 INFO - 'USER': 'cltbld', 09:06:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:56 INFO - 'XPC_FLAGS': '0x0', 09:06:56 INFO - 'XPC_SERVICE_NAME': '0', 09:06:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:56 INFO - Downloading/unpacking jsonschema==2.5.1 09:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:07:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:00 INFO - Downloading functools32-3.2.3-2.tar.gz 09:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:07:00 INFO - warning: no files found matching '*.txt' 09:07:00 INFO - no previously-included directories found matching 'build' 09:07:00 INFO - no previously-included directories found matching 'dist' 09:07:00 INFO - no previously-included directories found matching '.git*' 09:07:00 INFO - Installing collected packages: jsonschema, functools32 09:07:01 INFO - Running setup.py install for functools32 09:07:01 INFO - warning: no files found matching '*.txt' 09:07:01 INFO - no previously-included directories found matching 'build' 09:07:01 INFO - no previously-included directories found matching 'dist' 09:07:01 INFO - no previously-included directories found matching '.git*' 09:07:01 INFO - Successfully installed jsonschema functools32 09:07:01 INFO - Cleaning up... 09:07:01 INFO - Return code: 0 09:07:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:07:01 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')]} 09:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:01 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')]} 09:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:01 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 0x1100bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110035570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd38ad8b730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed3d30>, '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 0x10fd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fecbb20>, '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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:07:01 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 09:07:01 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 09:07:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGfzlOHHMO/Render', 09:07:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:01 INFO - 'HOME': '/Users/cltbld', 09:07:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:01 INFO - 'LOGNAME': 'cltbld', 09:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:01 INFO - 'MOZ_NO_REMOTE': '1', 09:07:01 INFO - 'NO_EM_RESTART': '1', 09:07:01 INFO - 'PAGER': '/bin/cat', 09:07:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:01 INFO - 'PWD': '/builds/slave/test', 09:07:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:01 INFO - 'SHELL': '/bin/bash', 09:07:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWtCgo0xmF/Listeners', 09:07:01 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:07:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:01 INFO - 'USER': 'cltbld', 09:07:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:01 INFO - 'XPC_FLAGS': '0x0', 09:07:01 INFO - 'XPC_SERVICE_NAME': '0', 09:07:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:07:01 INFO - Cleaning up... 09:07:01 INFO - Return code: 0 09:07:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:07:01 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')]} 09:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:01 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')]} 09:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:01 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 0x1100bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110035570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd38ad8b730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed3d30>, '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 0x10fd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fecbb20>, '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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:07:01 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 09:07:01 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 09:07:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGfzlOHHMO/Render', 09:07:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:01 INFO - 'HOME': '/Users/cltbld', 09:07:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:01 INFO - 'LOGNAME': 'cltbld', 09:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:01 INFO - 'MOZ_NO_REMOTE': '1', 09:07:01 INFO - 'NO_EM_RESTART': '1', 09:07:01 INFO - 'PAGER': '/bin/cat', 09:07:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:01 INFO - 'PWD': '/builds/slave/test', 09:07:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:01 INFO - 'SHELL': '/bin/bash', 09:07:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWtCgo0xmF/Listeners', 09:07:01 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:07:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:01 INFO - 'USER': 'cltbld', 09:07:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:01 INFO - 'XPC_FLAGS': '0x0', 09:07:01 INFO - 'XPC_SERVICE_NAME': '0', 09:07:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:01 INFO - Downloading/unpacking blobuploader==1.2.4 09:07:01 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 09:07:01 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 09:07:01 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 09:07:01 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 09:07:01 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 09:07:01 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 09:07:04 INFO - Downloading blobuploader-1.2.4.tar.gz 09:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:07:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:07:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:05 INFO - Downloading docopt-0.6.1.tar.gz 09:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:07:05 INFO - Installing collected packages: blobuploader, requests, docopt 09:07:05 INFO - Running setup.py install for blobuploader 09:07:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:07:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:07:05 INFO - Running setup.py install for requests 09:07:06 INFO - Running setup.py install for docopt 09:07:06 INFO - Successfully installed blobuploader requests docopt 09:07:06 INFO - Cleaning up... 09:07:06 INFO - Return code: 0 09:07:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:06 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 0x1100bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110035570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd38ad8b730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed3d30>, '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 0x10fd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fecbb20>, '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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:07:06 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 09:07:06 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 09:07:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGfzlOHHMO/Render', 09:07:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:06 INFO - 'HOME': '/Users/cltbld', 09:07:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:06 INFO - 'LOGNAME': 'cltbld', 09:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:06 INFO - 'MOZ_NO_REMOTE': '1', 09:07:06 INFO - 'NO_EM_RESTART': '1', 09:07:06 INFO - 'PAGER': '/bin/cat', 09:07:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:06 INFO - 'PWD': '/builds/slave/test', 09:07:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:06 INFO - 'SHELL': '/bin/bash', 09:07:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWtCgo0xmF/Listeners', 09:07:06 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:07:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:06 INFO - 'USER': 'cltbld', 09:07:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:06 INFO - 'XPC_FLAGS': '0x0', 09:07:06 INFO - 'XPC_SERVICE_NAME': '0', 09:07:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:06 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-nEJ_n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:06 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-4TnAA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:06 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-M_w9KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:07 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-gNJwEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:07 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Olc84L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:07 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-tpsidm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:07 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-6uUUSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:07 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-deaZFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:07 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ENKIBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:07 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-6vXAZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:07 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-CStlJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:07 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-SOq1wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:07 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-DN9LYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:08 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-FFUgxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:08 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Y9dcs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:08 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-_mYp57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:08 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-3EfxiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:07:08 INFO - Running setup.py install for manifestparser 09:07:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:07:08 INFO - Running setup.py install for mozcrash 09:07:08 INFO - Running setup.py install for mozdebug 09:07:08 INFO - Running setup.py install for mozdevice 09:07:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:07:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:07:09 INFO - Running setup.py install for mozfile 09:07:09 INFO - Running setup.py install for mozhttpd 09:07:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:07:09 INFO - Running setup.py install for mozinfo 09:07:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:07:09 INFO - Running setup.py install for mozInstall 09:07:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:07:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:07:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:07:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:07:09 INFO - Running setup.py install for mozleak 09:07:09 INFO - Running setup.py install for mozlog 09:07:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:07:10 INFO - Running setup.py install for moznetwork 09:07:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:07:10 INFO - Running setup.py install for mozprocess 09:07:10 INFO - Running setup.py install for mozprofile 09:07:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:07:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:07:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:07:10 INFO - Running setup.py install for mozrunner 09:07:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:07:10 INFO - Running setup.py install for mozscreenshot 09:07:10 INFO - Running setup.py install for moztest 09:07:10 INFO - Running setup.py install for mozversion 09:07:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:07:11 INFO - Cleaning up... 09:07:11 INFO - Return code: 0 09:07:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:11 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 0x1100bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110035570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd38ad8b730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed3d30>, '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 0x10fd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fecbb20>, '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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:07:11 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 09:07:11 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 09:07:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGfzlOHHMO/Render', 09:07:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:11 INFO - 'HOME': '/Users/cltbld', 09:07:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:11 INFO - 'LOGNAME': 'cltbld', 09:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:11 INFO - 'MOZ_NO_REMOTE': '1', 09:07:11 INFO - 'NO_EM_RESTART': '1', 09:07:11 INFO - 'PAGER': '/bin/cat', 09:07:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:11 INFO - 'PWD': '/builds/slave/test', 09:07:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:11 INFO - 'SHELL': '/bin/bash', 09:07:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWtCgo0xmF/Listeners', 09:07:11 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:07:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:11 INFO - 'USER': 'cltbld', 09:07:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:11 INFO - 'XPC_FLAGS': '0x0', 09:07:11 INFO - 'XPC_SERVICE_NAME': '0', 09:07:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-JZqUwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:11 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)) 09:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-7nQ63u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-wJ_M1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:11 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)) 09:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-saXuMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-_1tWLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:11 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)) 09:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:11 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Vw8dxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-_1Rv1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-b0Ssb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-hFsT2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Ex7ELa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-SkGdy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-byPGBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-qbsKzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-0KNVHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-yporQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:12 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-VuiLfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:13 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-DlrNvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:13 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)) 09:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:07:13 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)) 09:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:07:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:15 INFO - Downloading blessings-1.6.tar.gz 09:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:07:16 INFO - Installing collected packages: blessings 09:07:16 INFO - Running setup.py install for blessings 09:07:16 INFO - Successfully installed blessings 09:07:16 INFO - Cleaning up... 09:07:16 INFO - Return code: 0 09:07:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:07:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:16 INFO - Reading from file tmpfile_stdout 09:07:16 INFO - Current package versions: 09:07:16 INFO - blessings == 1.6 09:07:16 INFO - blobuploader == 1.2.4 09:07:16 INFO - docopt == 0.6.1 09:07:16 INFO - functools32 == 3.2.3-2 09:07:16 INFO - jsonschema == 2.5.1 09:07:16 INFO - manifestparser == 1.1 09:07:16 INFO - mozInstall == 1.12 09:07:16 INFO - mozcrash == 0.17 09:07:16 INFO - mozdebug == 0.1 09:07:16 INFO - mozdevice == 0.48 09:07:16 INFO - mozfile == 1.2 09:07:16 INFO - mozhttpd == 0.7 09:07:16 INFO - mozinfo == 0.9 09:07:16 INFO - mozleak == 0.1 09:07:16 INFO - mozlog == 3.4 09:07:16 INFO - moznetwork == 0.27 09:07:16 INFO - mozprocess == 0.23 09:07:16 INFO - mozprofile == 0.28 09:07:16 INFO - mozrunner == 6.12 09:07:16 INFO - mozscreenshot == 0.1 09:07:16 INFO - mozsystemmonitor == 0.3 09:07:16 INFO - moztest == 0.7 09:07:16 INFO - mozversion == 1.4 09:07:16 INFO - psutil == 3.1.1 09:07:16 INFO - requests == 1.2.3 09:07:16 INFO - wsgiref == 0.1.2 09:07:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:17 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')]} 09:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:17 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 0x1100bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110035570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd38ad8b730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed3d30>, '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 0x10fd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fecbb20>, '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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:07:17 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 09:07:17 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 09:07:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGfzlOHHMO/Render', 09:07:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:17 INFO - 'HOME': '/Users/cltbld', 09:07:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:17 INFO - 'LOGNAME': 'cltbld', 09:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:17 INFO - 'MOZ_NO_REMOTE': '1', 09:07:17 INFO - 'NO_EM_RESTART': '1', 09:07:17 INFO - 'PAGER': '/bin/cat', 09:07:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:17 INFO - 'PWD': '/builds/slave/test', 09:07:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:17 INFO - 'SHELL': '/bin/bash', 09:07:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWtCgo0xmF/Listeners', 09:07:17 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:07:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:17 INFO - 'USER': 'cltbld', 09:07:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:17 INFO - 'XPC_FLAGS': '0x0', 09:07:17 INFO - 'XPC_SERVICE_NAME': '0', 09:07:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:17 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)) 09:07:17 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)) 09:07:17 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)) 09:07:17 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)) 09:07:17 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)) 09:07:17 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)) 09:07:17 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)) 09:07:17 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)) 09:07:17 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)) 09:07:17 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)) 09:07:17 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)) 09:07:17 INFO - Cleaning up... 09:07:17 INFO - Return code: 0 09:07:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:07:17 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')]} 09:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:17 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')]} 09:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:17 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 0x1100bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110035570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd38ad8b730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed3d30>, '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 0x10fd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fecbb20>, '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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:07:17 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 09:07:17 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 09:07:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGfzlOHHMO/Render', 09:07:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:17 INFO - 'HOME': '/Users/cltbld', 09:07:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:17 INFO - 'LOGNAME': 'cltbld', 09:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:17 INFO - 'MOZ_NO_REMOTE': '1', 09:07:17 INFO - 'NO_EM_RESTART': '1', 09:07:17 INFO - 'PAGER': '/bin/cat', 09:07:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:17 INFO - 'PWD': '/builds/slave/test', 09:07:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:17 INFO - 'SHELL': '/bin/bash', 09:07:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWtCgo0xmF/Listeners', 09:07:17 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:07:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:17 INFO - 'USER': 'cltbld', 09:07:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:17 INFO - 'XPC_FLAGS': '0x0', 09:07:17 INFO - 'XPC_SERVICE_NAME': '0', 09:07:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:07:17 INFO - Cleaning up... 09:07:17 INFO - Return code: 0 09:07:17 INFO - Running post-action listener: _resource_record_post_action 09:07:17 INFO - Running post-action listener: _start_resource_monitoring 09:07:17 INFO - Starting resource monitoring. 09:07:17 INFO - [mozharness: 2016-10-24 16:07:17.623549Z] Finished create-virtualenv step (success) 09:07:17 INFO - [mozharness: 2016-10-24 16:07:17.624508Z] Running install step. 09:07:17 INFO - Running pre-action listener: _resource_record_pre_action 09:07:17 INFO - Running main action method: install 09:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:17 INFO - Reading from file tmpfile_stdout 09:07:17 INFO - Detecting whether we're running mozinstall >=1.0... 09:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:07:17 INFO - Reading from file tmpfile_stdout 09:07:17 INFO - Output received: 09:07:17 INFO - Usage: mozinstall [options] installer 09:07:17 INFO - Options: 09:07:17 INFO - -h, --help show this help message and exit 09:07:17 INFO - -d DEST, --destination=DEST 09:07:17 INFO - Directory to install application into. [default: 09:07:17 INFO - "/builds/slave/test"] 09:07:17 INFO - --app=APP Application being installed. [default: firefox] 09:07:17 INFO - mkdir: /builds/slave/test/build/application 09:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:07:50 INFO - Reading from file tmpfile_stdout 09:07:50 INFO - Output received: 09:07:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:07:50 INFO - Running post-action listener: _resource_record_post_action 09:07:50 INFO - [mozharness: 2016-10-24 16:07:50.439371Z] Finished install step (success) 09:07:50 INFO - [mozharness: 2016-10-24 16:07:50.439532Z] Running run-tests step. 09:07:50 INFO - Running pre-action listener: _resource_record_pre_action 09:07:50 INFO - Running main action method: run_tests 09:07:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:07:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:07:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:07:50 INFO - 2016-10-24 09:07:50.454 screenresolution[1634:7357] starting screenresolution argv=screenresolution get 09:07:50 INFO - 2016-10-24 09:07:50.456 screenresolution[1634:7357] Display 0: 1600x1200x32@60 09:07:50 INFO - 2016-10-24 09:07:50.462 screenresolution[1635:7359] starting screenresolution argv=screenresolution list 09:07:50 INFO - Available Modes on Display 0 09:07:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:07:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:07:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:07:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:07:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:07:50 INFO - Intel Iris: 09:07:50 INFO - Chipset Model: Intel Iris 09:07:50 INFO - Type: GPU 09:07:50 INFO - Bus: Built-In 09:07:50 INFO - VRAM (Dynamic, Max): 1536 MB 09:07:50 INFO - Vendor: Intel (0x8086) 09:07:50 INFO - Device ID: 0x0a2e 09:07:50 INFO - Revision ID: 0x0009 09:07:50 INFO - Displays: 09:07:50 INFO - Display: 09:07:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:07:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:07:50 INFO - Display Serial Number: 1600x1200 60 09:07:50 INFO - Main Display: Yes 09:07:50 INFO - Mirror: Off 09:07:50 INFO - Online: Yes 09:07:50 INFO - Rotation: Supported 09:07:50 INFO - Return code: 0 09:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:07:50 INFO - Python 2.7.3 09:07:50 INFO - Return code: 0 09:07:50 INFO - grabbing minidump binary from tooltool 09:07: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')]} 09:07: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 0x10fed3d30>, '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 0x10fd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fecbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:07: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 09:07: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 09:07: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 09:07:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:07:50 INFO - Return code: 0 09:07:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:07:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:07:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:07:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:07:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:07:50 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/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 09:07:50 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/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0281 --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 09:07:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGfzlOHHMO/Render', 09:07:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:50 INFO - 'HOME': '/Users/cltbld', 09:07:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:50 INFO - 'LOGNAME': 'cltbld', 09:07:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:07:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:50 INFO - 'MOZ_NO_REMOTE': '1', 09:07:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:07:50 INFO - 'NO_EM_RESTART': '1', 09:07:50 INFO - 'PAGER': '/bin/cat', 09:07:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:50 INFO - 'PWD': '/builds/slave/test', 09:07:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:07:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:50 INFO - 'SHELL': '/bin/bash', 09:07:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gWtCgo0xmF/Listeners', 09:07:50 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:07:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:50 INFO - 'USER': 'cltbld', 09:07:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:50 INFO - 'XPC_FLAGS': '0x0', 09:07:50 INFO - 'XPC_SERVICE_NAME': '0', 09:07:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:50 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/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 09:07:51 INFO - mozversion application_buildid: 20161024063222 09:07:51 INFO - mozversion application_changeset: 0997fc0a73e859e7ed7c9d9765dcf96dbe9e4b95 09:07:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:07:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:07:51 INFO - mozversion application_name: Firefox 09:07:51 INFO - mozversion application_remotingname: firefox-dev 09:07:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:51 INFO - mozversion application_vendor: Mozilla 09:07:51 INFO - mozversion application_version: 51.0a2 09:07:51 INFO - mozversion platform_buildid: 20161024063222 09:07:51 INFO - mozversion platform_changeset: 0997fc0a73e859e7ed7c9d9765dcf96dbe9e4b95 09:07:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:51 INFO - mozversion platform_version: 51.0a2 09:07:51 INFO - using testdate: 1477325271 09:07:51 INFO - actual date: 1477325271 09:07:51 INFO - starting webserver on 'localhost:49268' 09:07:51 INFO - SUITE-START | Running 2 tests 09:07:51 INFO - TEST-START | dromaeo_css 09:07:51 INFO - operating with platform_type : mac_ 09:07:51 INFO - Initialising browser for dromaeo_css test... 09:07:51 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpJIYjqc/profile http://localhost:49268/getInfo.html) 09:07:53 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 09:07:53 INFO - PROCESS | 1645 | colorDepth:24 09:07:53 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 09:07:53 INFO - PROCESS | 1645 | __metrics 09:07:53 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:07:53 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:54 INFO - TEST-INFO | 1645: exit 0 09:07:54 INFO - Browser initialized. 09:07:54 INFO - Running cycle 1/1 for dromaeo_css test... 09:07:54 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpJIYjqc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:06 INFO - PROCESS | 1647 | RSS: Main: 219754496 09:08:06 INFO - PROCESS | 1647 | 09:08:57 INFO - PROCESS | 1647 | 1477325337113 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:11:08 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 09:11:10 INFO - PROCESS | 1647 | RSS: Main: 373882880 09:11:10 INFO - PROCESS | 1647 | 09:14:13 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 09:14:13 INFO - PROCESS | 1647 | RSS: Main: 352391168 09:14:13 INFO - PROCESS | 1647 | 09:17:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 09:17:16 INFO - PROCESS | 1647 | RSS: Main: 349286400 09:17:16 INFO - PROCESS | 1647 | 09:20:18 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 09:20:19 INFO - PROCESS | 1647 | RSS: Main: 324923392 09:20:19 INFO - PROCESS | 1647 | 09:23:22 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 09:23:23 INFO - PROCESS | 1647 | RSS: Main: 313536512 09:23:23 INFO - PROCESS | 1647 | 09:26:26 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 09:26:26 INFO - PROCESS | 1647 | RSS: Main: 562978816 09:26:26 INFO - PROCESS | 1647 | 09:26:26 INFO - PROCESS | 1647 | __start_tp_report 09:26:26 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 09:26:26 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 09:26:26 INFO - PROCESS | 1647 | |i|pagename|runs| 09:26:26 INFO - PROCESS | 1647 | |0;dojo.html;2793.5251007328757;3322.637718535401;3375.139339468435;3384.2385463270753;3413.4026545354573;5630.352509461413;5699.287589051369;5728.226689396935;5732.828015159542;5739;5661.094224924002;5731.283589551306;5733.856653583663;5746.339170995337;5761;5144.331236939202;5180.559652429548;5197.662151960129;5211.400688920785;5245.370555533342;5138.383393992726;5151.562117220041;5162.277281180619;5276.577873770089;5325.20121981702;4556.70381425208;5173.30160428343;5178.40448348441;5227.4511176326505;5240.213967904826;5144.6655967362185;5161.638685292031;5223.268742376071;5228.4510126436935;5265.921011184835;5060.46865079165;5093.18509038552;5168.250603662448;5178;5202.687838729688;5620.213170156181;5651.9717401413145;5653.745581448845;5676.318841739017;5726.971365143189;5753.942460575383;5775.844831033768;6186.072089186613;6297.559170858041;6333.9683301583655;6277.497800175975;6284.458649620474;6321.6523091229965;6321.74713011479;6361;5705.657660540381;5776.133579963039;5778.682172480554;5827.155062515912;5845.298564172242;6227.844303892439;6243.96878015607;6259.561830671901;6260.123582698426;6276.466500347522;6188.845278867974;6217.906731399033;6234.75060997555;6238.157848690369;6240.625562466266;6112.74665817949;6180.6600636965395;6215.34738852414;6270.059491076375;6300.432961033437;6196.194494715748;6255.999040153553;6258.374162583706;6270.372962703785;6282.685865706696;6248.843778905563;6273.8745225095245;6273.937260627426;6291.213598300213;6303;4865.659403841697;4910.435299940481;4987.351644286219;4991.975040124848;5009.398872135367;4426.402435671208;4471.8434854779925;4475.239209334356;4476.955230447719;4493.505714371417;5835.854103647443;5841.41585841421;5861.677607731615;5862;5864.149698293723;6273.65494897785;6278.4035516625845;6292.559520833589;6305.117283580303;6320.4311611955145;5619.297587801525;5725.51333136688;5736;5747.885042299215;5811.651300921958;5426.158945363475;5450.482204190595;5459.563234941195;5463.153211252262;5472.151816468454;6362.809115726535;6365.140706004723;6374;6380.298167201604;6400.295967443578;6116.510679145568;6207.037909124093;6215.378462153749;6280.874382512416;6352.078948552342;6223.159873417212;6251.906221406592;6260.74957001733;6342.39747224013;6369.8726025480155;5242.580593552583;6209.534284928558;6258.874822503615;6266.68666566679;6280.183576135073;6239.344868788712;6244.594101383395;6246.3441338660605;6305.716242768995;6332.746690132343;5761.884762304814;5966.671833049224;6061.545384096298;6079.1793107931635;6105.664188469676;6154.446099851035;6165.568410211242;6171.105189747372;6179.196704428396;6188.44304012623;5898.793542226002;5996.820095397145;6024.638521688713;6046.486048685735;6056.848578785565;5986.640801551921;6077.696115194134;6098.695065246809;6121.143039974496;6175.073738939195;6055.182550355646;6071.119687645179;6071.726772295169;6090.573659843945;6091.360407157184 09:26:26 INFO - PROCESS | 1647 | |1;ext.html;489.89712160446305;519.8206618716542;524.1613418530352;545.2393910494862;558.193410521796;32451.02646920593;39890.80054599726;40816.795916020455;41036.79481602592;43263;42943.57056429435;42979;43258.48595299165;43299.78350108245;43376.566234337646;9789.804203915899;9961.053699898534;9968.900310996905;9975.551100200471;9976.002399760002;8755.693550725726;9003.639854405816;12003;12245.938770306137;12288.139830211889;12269.44787484561;12355.814662780065;12366.258024518558;12375.257484550955;12377.876221237762;12201.877981220163;12273.815892761615;12288.324142172178;12289.56986505468;12306.015518758522;12082.879171208351;12143.02855771536;12147.757044859141;12157.756844863141;12159.452824622826;40638;40884.97787555335;40944;40950.38574421386;40968.59031409678;3370.4775759757276;3524.400851855165;3558.19940513385;3586.605473397924;3812.4471951567143;29960.550591741143;30939.84530077335;31058.378832423226;31313.843430782927;32372.514412283836;3126.171564535377;3139.262273365757;3146.5594816725675;3211.71094601487;3275;520251;522936;524782.376088121;526274;526649;62521.68739156275;62951.6852415735;62998.68500657559;63071.36928630747;63110.36889631045;34309.656903430645;34665.30669386598;34795.13012174665;36482.81758591243;65386.346136538974;16757.07836069028;16889.408870689465;16907.577310567332;16909.7463538047;16912.408065717642;11618.825717614243;11849.526018959144;12927.676808079874;13004.479820807252;13030.609081727564;19289.035548222815;19349.03254837281;19586.608267834563;19898.801011989985;20055.899720501595;6925.411340036053;7046.260142685047;7202.099737532809;7587.696492140363;8052.396070294752;866.7139843851514;932.5197523275518;959.3524371049514;970.1705042188968;1069.769999450122;28910.132696019155;29775;29941;30574;30699.386012280076;960.4525420510242;1099.3294090604725;1135.971600709989;1138.174823253135;1138.3113216504062;15529.922350388175;15572.766408503881;15618.68762624741;15694.686106278039;15938.36246550125;694964;702030;702513;702701;704539;48125.51874481211;58401.123983140285;58909;59145.70427147837;59212.11181832276;1256.5727652597977;1282.6665067082627;1380.061558140434;1402.558194168854;1414.3988804757937;29403.41193176167;30695.386092278477;30973.690263097982;31111.68888311088;31823;50070.749646251534;50577.49422505728;50580;50640;50642.74678626583;520408;523209;523625;525234;525441;26735;27503.86248068827;27539.72460275452;28398.43203135967;28414.289642759097;47480.762596186796;47745;47977.04045919132;48131.518684812705;48217.517824821305;33028.34455274159;39015.60984390233;39124.41313380359;39628.80185599169;40523;38686.80656596699;39448.605513944494;40527;40585.39121913115;40633.39049914195;37525.62474375221;37647.81176094102;37679.81160094182;37915.86252412432;37934.430983534716;32723.34553308968;34145.14637133992;34511.65488345185;34794.82602586971;34899.65100349065;25566.488670226863;25666.74333256718;25855.756407246285;25940.870295649154;25997.870010649825 09:26:26 INFO - PROCESS | 1647 | |2;jquery.html;337.7669408108404;341.5832684125367;352.20401891724697;361.31711066085103;398.6770715720267;15239.542813715592;15527.534173974771;16360.754588681164;20918.163273469043;21204.833734144653;19647;20067.698984515206;20559.8692071936;20951.266705665304;21432.785672143273;5893.322267939177;5910.763569457216;6162.537809664271;6163.938360616404;6180.505559555248;4635.58279754822;6058.727357268934;6115.48018418435;6126.326104128542;6132.233470816148;5828.795992140276;5986.640801551899;6109.541784366168;6111.633302001894;6114.785982490614;5874.236349274588;6034.215551978258;6082.300535438437;6087.6956152192215;6105.41998510143;5090.465501122366;5290.841274761763;5291.920621190685;5521.337439507285;5589.692566908819;13127.934360328138;13404.396802143927;13406.93296533511;15945.601359965978;25153.748462515323;2227.20934068405;2309.3880121767743;2367.2661474942824;2374.726906405751;2568.2166939083572;10032.097111260022;10475.1096156826;10515.684529464128;10757.784844303149;11085.060114480015;1592.864606508448;1692.7642820740928;1793.2199493220492;1826.8447181989548;1830.066666000336;121248.39375803065;122577;125758.3712081443;128839.06741398887;129212.3539382297;11096.667099987013;11223.551057957753;11395.544178232778;11611.76776464466;11761.88238117625;14529.418823247162;14530.854691453162;14544.200068996095;14547.27263636814;14559.3448294827;8402.201790829862;8634.740957771277;8642.265407440313;8747.431416958005;8754.56227188638;8639.524826134497;8651.48091114535;8667;8808.911910880937;8859;4394.560543945579;4482.350059241457;4495.303227999665;4555.612772914273;4575.313702944585;1892.9053547322578;1894.5737209128113;1908.4560900143392;1916.7891531931477;1963.1165975310882;828.6975254032355;916.1022198245756;996.1433167475965;1006.0141061759516;1006.8691070160833;17805.198766055557;19313.51716207078;19809.306674266332;21103.17495969543;21438.785612143678;914.6387177065022;927.3369540778376;947.6351604632266;990.7374545745383;1022.4121130350078;10223.284370094021;10835.51240194193;10848.132149428027;10856;10867.29362591429;560131;571288;576512;580283;592991;89338.55330723304;90161;94892;121454;128596;862.4135587800356;912.4388501071926;968.1915600473543;972.7568107973007;977.0864241933815;18871.811281887007;19187.424377268704;19241.711374329116;19434.90282548578;19474;46650;46825.76587117043;47227.34704285333;52652;53253;67800;68652.656736716;69319;71166.64416677883;74801.87797183155;7159.284071592799;7705.922940770521;7880.84238315242;8034.63844127004;8160.347172226327;11625.534978600761;12514.249145051326;12575.245485270912;12756.936215318863;13016.609501714964;11085.27945683528;11282.53327067476;11308;11334.773304534028;11352.602658906899;9588.856167157637;10824.945875270574;10983.83524247121;11186.216964812385;11390;9237.445753254826;11131.55473781072;11261.943690281823;11622.0702343814;11650.242734222249;6583.407493325623;7063.788086357417;7322.743703970548;7329.633518323956;7466;9375.10936461035;10863.511141998788;11100.444977750918;11311.717207069889;11393.943030284796 09:26:26 INFO - PROCESS | 1647 | |3;mootools.html;1388.3960477192422;1502;1685.4522280258911;1825.497988053286;1888.848892088633;8512.616932238048;9043.276537876962;9056.456612603248;9059.275257979361;9067.909320906789;7830.29527342539;8087.9191208087905;8110.635021424036;8568;8752.431091979017;2161.427221786228;2374.2639781667654;2390.725066617344;2425.4785221177444;2427.9393015174587;2375.5248950210025;2390.8087353011806;2427.78149966503;2434.9878250608813;2435.902563897442;1914.5117994911277;2111.567128738605;2190.8904554772275;2272.545490901818;2351.318117745852;2403.098837935774;2423.285130886375;2425.34515680767;2426.5389575980507;2429.8663573503363;2384.5826980278557;2415.1909110448023;2416.1905761569897;2416.5166966606575;2422.7456117107804;8928.508932008737;9015.819683606356;9033.638654453815;9035.683751068747;9051.547422628842;5282.7622756976025;5384.40771515133;5445.700486473243;5446.564274858002;5453.7818487260465;3370.646082161387;3414.4878268259713;3485.790852548855;3558.946615800765;3566.7859928404378;1008.9293749437543;1010.3432768700403;1023.053675350298;1024.7694268789537;1032.5818043692316;11942.582009629708;11944.522219111224;11947.522099116024;11966.401679916056;12014.339211343373;4522.208613492691;4870.172070747911;4915.5330243626795;4917.680350777188;4938.58022068121;10122.240831937634;10128.240381971234;10132.949335253277;10147.137493313152;10168.898311016943;5396.568274538027;5422.566194704415;5427.0773968425465;5433.185022246695;5437.45625437461;4800.399950006249;4882.829100981448;4973.577245934136;4976.776045077981;4992.700437973734;3449.6377880322207;3966.6231707987695;3999.440078389028;4087.346024636044;4111.383292506088;1282.224254326138;1289.1620446709715;1295.33290355467;1310.2989900403238;1312.4618906248393;622.9067985685184;759.0928840036104;789.1280135450245;855.9486430814171;931.4830269200659;5795.420457954171;5799.217105690762;5857;6071.817845464643;6134.957057300269;856.2122846980793;915.2997956563235;921.1433366968784;968.1963969904962;983.095552092077;3833.9424908626393;3920.843166273374;3959.4852669152824;3965.0285680008583;4063.6342729153926;10437.165026797838;10543.314684545634;10812.405317707602;10987.39569323695;11010.339379637247;10893.07408870255;10900.291481053706;10927.453627318602;10929;10946.343219406703;8134.837303253902;8238.134995825472;8270.710525131592;8380.413371063967;8418.368622353226;5610.551155907599;5846.298444186725;5847.06446968483;5896.380880007538;5958.433948774859;9968.950155249177;10106.444145572064;10272.640457583948;10276.640317588848;10282.845757313797;9788;10192.847107293248;10479.214058945761;10486.94756526243;10488.94755526248;7484.32641062307;7575.507592006502;7580.1661817198965;7588.127365353055;7616.961915190389;8313.002439707274;8403.663853446038;8410.327173825957;8411.831763364577;8421.873671894804;7360.852782944418;7477.439192060726;7519.699212031457;7519.887201692089;7521.360684341674;7320.487565870338;7387.852242955003;7388.889166662612;7415.851682966419;7436.107667079985;6931.133608298963;7071.7878463646175;7072.398846098139;7076.823079423056;7081.008658787877;4438.689291749675;4896.706197628011;5015.821281998655;5025.522575355335;5070.062038522885;4854.490278520846;4944.6785958914;5009;5102.821401251087;5193.0652482552 09:26:26 INFO - PROCESS | 1647 | |4;prototype.html;293.4322086762114;299.49236044903887;304.15445062725615;306.9232691827043;308.434023566755;5427.0773968425365;5452.737114097649;5469;5482.889087701229;5500.339959204891;4523.886902827431;5082.390113186413;5183.734247424127;5283.735813209334;5352.866178345544;3494.860205591773;3584.7132229421713;4080.7347522411096;4135.855245066431;4173.582641735818;3653.19629681471;3681.337359275329;4054.1148366009797;4141.813618387165;4171.520275168364;3396.507506411569;3424.7773894696766;3863.7681739095606;4044.9078748737825;4118.979405102985;4052.4326594276827;4053.837846486137;4055.4322394864744;4055.817488213023;4085.46888904442;3503.789772613651;3508.894663202084;3511.877084302063;3516.226430185355;3521.295740851814;4869.561739443467;5058.873528161788;5120.539151476385;5190.806114593627;5353.946460535384;3896.961030389688;4359.956400435986;4640.396748422717;4665.86002419928;4726.26742854858;4947.901041979177;4977;5655.943440565583;5680.318361796611;5738.569607279429;3696.9260614787822;3862.7875466849314;3865.2849222893856;3886.24218277436;3908.17928235071;4942.629302802268;5198.350206224222;5972.492338151219;5982.4914882234625;5983.521318294526;3476.80877551732;3788.299164654548;3910.608939106067;3916.1971795781797;3917.3928041153667;3245.545623612696;3967.4048892665755;3978.264021156095;3980.20395920817;3999.0604556789935;3865.2556684753577;4146.523149837807;4201.516825565099;4658.743769092733;4683.484816670163;4768.546988036201;5708.175522400002;5715;5738.962668252793;5756.769729210785;1145.7021174494525;1279.680079980005;1321.8612045735251;1360.2996254681648;1367.43934986655;855.9015713193063;875.487839613833;897.4794619121025;901.6799036342135;919.1911118215927;4758.833440829623;5312.62811603184;5366.6243362965;5373.2746079278795;5396.811111611075;4925.802967881316;5397.595180361489;5903.527717782567;5911.847189797948;5961.940380596226;5294.973525132426;5297.920531192035;5318.65428747138;5324.722066704041;5352.635078055071;2958.349163184096;2971.7919745618033;3055.816651000947;3064.8161110333454;3072.0799500312305;5662.348829884533;5933.525317974551;5993.370696076936;6021.819345419644;6042.160184713178;5287.41838397776;5943.167956486009;5951;5981.491573216325;6003.3996600339615;5619.438056194348;5851.531877449709;6003.849903752353;6085.726142323606;6091.269047714302;4110.636384079106;5235.581153507634;5395.271638328775;5657.717114144194;5928.733207005609;4958.404991401055;5517.393086760373;5647.15292706081;5877.265341832271;5911.733971971185;5056.342675452168;5460.453954604508;5673.404292549223;6144.2319710036245;6246.250449946036;3911.159100793343;3948.2103579283685;3951.2887680217837;3982.143839074613;3984.681225502011;4862.124817532878;5250.973745131403;5999.620087380014;6031.24609423822;6033.879322413615;5305.806193606562;5368.476815896523;5566.610337276514;5755.309362876482;5837.949169149424;5703.230063941315;5745.482906538432;5766.538676905921;5768.307803063659;5770.64389868389;4949.356583644248;5315.182953034898;5356.437574054668;5611.214429979887;5717.971410142923;5037.481259370315;5524.944750552443;5725.51333136688;5757.107648314518;5758.3090029196765;4826.61387089025;5326.147816349366;5423.728813559385;5639.915401269066;5668.967102600089 09:26:26 INFO - PROCESS | 1647 | |5;yui.html;589.498925912974;722.5664601239254;735.2280105888815;766.0615745711505;767.9961600191998;12283.938580307096;12823.679408014805;12853.164544304625;13179.07746457746;13262.801057984138;12627.621171364874;12635.747285054293;12676.80984785229;12738.490460381598;12761.617151485447;810.1655295046112;834.4159088637947;834.6035633074272;835.0980940584185;836.481381543444;660.6102399584245;681.924988251292;819.647551552832;847.9703210387606;850.3962186847315;899.4378513429107;899.8695189197563;900.4507250577143;901.900790912999;902.0213068820337;884.60192913189;886.8004698942751;886.9556522173898;887.951162686052;889.1064480197425;510.6884800271831;529.055635690291;638.7157714816908;660.6663634864411;661.8047675935611;13595.388207530685;13710.314484275747;13718.38267277975;13720.862791372057;13757;12936.353182340845;13157.407916643773;13238.404271807793;13316.134451260734;13845.584632461043;12002.819957700642;12190.57332993341;12276.570320038845;12466.127371084027;12593.811092833615;4062.614051665087;4256.148770245933;4264.253755592759;4309.956900430987;4403.031333106712;111910;112836.43581782038;120311;120789.77235796793;121507.39246303712;10332.535035923402;10477.47612619366;10631.46842657864;10725.03474687282;10764.946175269073;21001;21084.47288817792;21112;21125.9437028148;21268.680969785466;6926.134233220848;7022.683979220948;7072.823179420556;7081.645917704094;7163.606001669854;3829.195868867513;3921.9998900280816;3935.4883865097354;3956.050547868548;3957.584453632385;3173.6032995875516;3245.432049391347;3270.705636492727;3305.652906444837;3310.354480876206;628.3119983617931;628.7862126876884;632.8955722305768;635.5328833307515;638.4317957018258;507.47476361965187;527.8310940499081;562.5134258866133;587.2014060877203;592.1591340296789;6632.568883022588;7017.47368947331;8301.792455188668;8459.154084591491;8490.830183396298;537.4705914674043;576.3890276307128;577.8208755285875;593.403629352498;594.3373138950126;3913.099987003005;4061.756294622332;4071.714979951434;4176.331786914079;4242.087951090531;127029;127420;163318;169773;176995;124818;125277.8347139678;128338;132315;133266;97057.544136838;104148.95851041544;104381.47809261057;109941.45029274962;111570;9188.783925625978;9861.112499875046;9901.801963960825;9966.651167209113;9984.500774961369;52390;56628.15057774054;61652.69173654103;63044.68477657582;63460.04809927762;66523.67810575239;83258;86112.4026938247;87280.1271987272;90688;12660;13041.673958151123;13141.474341026253;13236.007299452773;13331.266780327174;14380.784288235476;14414.972855700002;14576.34406451691;14775.039622424509;15008.624784380478;13552.93223533876;13897.444102236203;13926.39846417675;13926.860731392557;14220.431182752574;12654.557090501788;12976.02679799;13052.869471305545;13418.530351437652;14371.85628143747;13113.672158196121;13506.122102063728;13676.452941882213;13911.791323130363;14077.648058798612;8840.867386989328;11524.078073753912;11739.23694959825;11870.703232419259;11883.465244063866;10262.89610629834;10784.91903841917;11566.132540059698;11643.825342620037;11727.589534366256 09:26:26 INFO - PROCESS | 1647 | __end_tp_report 09:26:26 INFO - PROCESS | 1647 | __start_cc_report 09:26:26 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1455 09:26:26 INFO - PROCESS | 1647 | __end_cc_report 09:26:26 INFO - PROCESS | 1647 | __startTimestamp1477326386588__endTimestamp 09:26:26 INFO - PROCESS | 1647 | 09:26:26 INFO - PROCESS | 1647 | ------- Summary: start ------- 09:26:26 INFO - PROCESS | 1647 | Number of tests: 6 09:26:26 INFO - PROCESS | 1647 | 09:26:26 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5754.35 Median:5996.82 stddev:664.64 (11.1%) stddev-sans-first:624.77 09:26:26 INFO - PROCESS | 1647 | Values: 2793.5 3322.6 3375.1 3384.2 3413.4 5630.4 5699.3 5728.2 5732.8 5739.0 5661.1 5731.3 5733.9 5746.3 5761.0 5144.3 5180.6 5197.7 5211.4 5245.4 5138.4 5151.6 5162.3 5276.6 5325.2 4556.7 5173.3 5178.4 5227.5 5240.2 5144.7 5161.6 5223.3 5228.5 5265.9 5060.5 5093.2 5168.3 5178.0 5202.7 5620.2 5652.0 5653.7 5676.3 5727.0 5753.9 5775.8 6186.1 6297.6 6334.0 6277.5 6284.5 6321.7 6321.7 6361.0 5705.7 5776.1 5778.7 5827.2 5845.3 6227.8 6244.0 6259.6 6260.1 6276.5 6188.8 6217.9 6234.8 6238.2 6240.6 6112.7 6180.7 6215.3 6270.1 6300.4 6196.2 6256.0 6258.4 6270.4 6282.7 6248.8 6273.9 6273.9 6291.2 6303.0 4865.7 4910.4 4987.4 4992.0 5009.4 4426.4 4471.8 4475.2 4477.0 4493.5 5835.9 5841.4 5861.7 5862.0 5864.1 6273.7 6278.4 6292.6 6305.1 6320.4 5619.3 5725.5 5736.0 5747.9 5811.7 5426.2 5450.5 5459.6 5463.2 5472.2 6362.8 6365.1 6374.0 6380.3 6400.3 6116.5 6207.0 6215.4 6280.9 6352.1 6223.2 6251.9 6260.7 6342.4 6369.9 5242.6 6209.5 6258.9 6266.7 6280.2 6239.3 6244.6 6246.3 6305.7 6332.7 5761.9 5966.7 6061.5 6079.2 6105.7 6154.4 6165.6 6171.1 6179.2 6188.4 5898.8 5996.8 6024.6 6046.5 6056.8 5986.6 6077.7 6098.7 6121.1 6175.1 6055.2 6071.1 6071.7 6090.6 6091.4 09:26:26 INFO - PROCESS | 1647 | 09:26:26 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:71327.06 Median:3572.40 stddev:157529.58 (4409.6%) stddev-sans-first:157881.71 09:26:26 INFO - PROCESS | 1647 | Values: 489.9 519.8 524.2 545.2 558.2 32451.0 39890.8 40816.8 41036.8 43263.0 42943.6 42979.0 43258.5 43299.8 43376.6 9789.8 9961.1 9968.9 9975.6 9976.0 8755.7 9003.6 12003.0 12245.9 12288.1 12269.4 12355.8 12366.3 12375.3 12377.9 12201.9 12273.8 12288.3 12289.6 12306.0 12082.9 12143.0 12147.8 12157.8 12159.5 40638.0 40885.0 40944.0 40950.4 40968.6 3370.5 3524.4 3558.2 3586.6 3812.4 29960.6 30939.8 31058.4 31313.8 32372.5 3126.2 3139.3 3146.6 3211.7 3275.0 520251.0 522936.0 524782.4 526274.0 526649.0 62521.7 62951.7 62998.7 63071.4 63110.4 34309.7 34665.3 34795.1 36482.8 65386.3 16757.1 16889.4 16907.6 16909.7 16912.4 11618.8 11849.5 12927.7 13004.5 13030.6 19289.0 19349.0 19586.6 19898.8 20055.9 6925.4 7046.3 7202.1 7587.7 8052.4 866.7 932.5 959.4 970.2 1069.8 28910.1 29775.0 29941.0 30574.0 30699.4 960.5 1099.3 1136.0 1138.2 1138.3 15529.9 15572.8 15618.7 15694.7 15938.4 694964.0 702030.0 702513.0 702701.0 704539.0 48125.5 58401.1 58909.0 59145.7 59212.1 1256.6 1282.7 1380.1 1402.6 1414.4 29403.4 30695.4 30973.7 31111.7 31823.0 50070.7 50577.5 50580.0 50640.0 50642.7 520408.0 523209.0 523625.0 525234.0 525441.0 26735.0 27503.9 27539.7 28398.4 28414.3 47480.8 47745.0 47977.0 48131.5 48217.5 33028.3 39015.6 39124.4 39628.8 40523.0 38686.8 39448.6 40527.0 40585.4 40633.4 37525.6 37647.8 37679.8 37915.9 37934.4 32723.3 34145.1 34511.7 34794.8 34899.7 25566.5 25666.7 25855.8 25940.9 25997.9 09:26:26 INFO - PROCESS | 1647 | 09:26:26 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:33305.80 Median:13860.98 stddev:96032.81 (692.8%) stddev-sans-first:96270.30 09:26:26 INFO - PROCESS | 1647 | Values: 337.8 341.6 352.2 361.3 398.7 15239.5 15527.5 16360.8 20918.2 21204.8 19647.0 20067.7 20559.9 20951.3 21432.8 5893.3 5910.8 6162.5 6163.9 6180.5 4635.6 6058.7 6115.5 6126.3 6132.2 5828.8 5986.6 6109.5 6111.6 6114.8 5874.2 6034.2 6082.3 6087.7 6105.4 5090.5 5290.8 5291.9 5521.3 5589.7 13127.9 13404.4 13406.9 15945.6 25153.7 2227.2 2309.4 2367.3 2374.7 2568.2 10032.1 10475.1 10515.7 10757.8 11085.1 1592.9 1692.8 1793.2 1826.8 1830.1 121248.4 122577.0 125758.4 128839.1 129212.4 11096.7 11223.6 11395.5 11611.8 11761.9 14529.4 14530.9 14544.2 14547.3 14559.3 8402.2 8634.7 8642.3 8747.4 8754.6 8639.5 8651.5 8667.0 8808.9 8859.0 4394.6 4482.4 4495.3 4555.6 4575.3 1892.9 1894.6 1908.5 1916.8 1963.1 828.7 916.1 996.1 1006.0 1006.9 17805.2 19313.5 19809.3 21103.2 21438.8 914.6 927.3 947.6 990.7 1022.4 10223.3 10835.5 10848.1 10856.0 10867.3 560131.0 571288.0 576512.0 580283.0 592991.0 89338.6 90161.0 94892.0 121454.0 128596.0 862.4 912.4 968.2 972.8 977.1 18871.8 19187.4 19241.7 19434.9 19474.0 46650.0 46825.8 47227.3 52652.0 53253.0 67800.0 68652.7 69319.0 71166.6 74801.9 7159.3 7705.9 7880.8 8034.6 8160.3 11625.5 12514.2 12575.2 12756.9 13016.6 11085.3 11282.5 11308.0 11334.8 11352.6 9588.9 10824.9 10983.8 11186.2 11390.0 9237.4 11131.6 11261.9 11622.1 11650.2 6583.4 7063.8 7322.7 7329.6 7466.0 9375.1 10863.5 11100.4 11311.7 11393.9 09:26:26 INFO - PROCESS | 1647 | 09:26:26 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5770.01 Median:4916.61 stddev:3262.73 (66.4%) stddev-sans-first:3255.27 09:26:26 INFO - PROCESS | 1647 | Values: 1388.4 1502.0 1685.5 1825.5 1888.8 8512.6 9043.3 9056.5 9059.3 9067.9 7830.3 8087.9 8110.6 8568.0 8752.4 2161.4 2374.3 2390.7 2425.5 2427.9 2375.5 2390.8 2427.8 2435.0 2435.9 1914.5 2111.6 2190.9 2272.5 2351.3 2403.1 2423.3 2425.3 2426.5 2429.9 2384.6 2415.2 2416.2 2416.5 2422.7 8928.5 9015.8 9033.6 9035.7 9051.5 5282.8 5384.4 5445.7 5446.6 5453.8 3370.6 3414.5 3485.8 3558.9 3566.8 1008.9 1010.3 1023.1 1024.8 1032.6 11942.6 11944.5 11947.5 11966.4 12014.3 4522.2 4870.2 4915.5 4917.7 4938.6 10122.2 10128.2 10132.9 10147.1 10168.9 5396.6 5422.6 5427.1 5433.2 5437.5 4800.4 4882.8 4973.6 4976.8 4992.7 3449.6 3966.6 3999.4 4087.3 4111.4 1282.2 1289.2 1295.3 1310.3 1312.5 622.9 759.1 789.1 855.9 931.5 5795.4 5799.2 5857.0 6071.8 6135.0 856.2 915.3 921.1 968.2 983.1 3833.9 3920.8 3959.5 3965.0 4063.6 10437.2 10543.3 10812.4 10987.4 11010.3 10893.1 10900.3 10927.5 10929.0 10946.3 8134.8 8238.1 8270.7 8380.4 8418.4 5610.6 5846.3 5847.1 5896.4 5958.4 9969.0 10106.4 10272.6 10276.6 10282.8 9788.0 10192.8 10479.2 10486.9 10488.9 7484.3 7575.5 7580.2 7588.1 7617.0 8313.0 8403.7 8410.3 8411.8 8421.9 7360.9 7477.4 7519.7 7519.9 7521.4 7320.5 7387.9 7388.9 7415.9 7436.1 6931.1 7071.8 7072.4 7076.8 7081.0 4438.7 4896.7 5015.8 5025.5 5070.1 4854.5 4944.7 5009.0 5102.8 5193.1 09:26:26 INFO - PROCESS | 1647 | 09:26:26 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4578.79 Median:5216.97 stddev:1425.29 (27.3%) stddev-sans-first:1392.52 09:26:26 INFO - PROCESS | 1647 | Values: 293.4 299.5 304.2 306.9 308.4 5427.1 5452.7 5469.0 5482.9 5500.3 4523.9 5082.4 5183.7 5283.7 5352.9 3494.9 3584.7 4080.7 4135.9 4173.6 3653.2 3681.3 4054.1 4141.8 4171.5 3396.5 3424.8 3863.8 4044.9 4119.0 4052.4 4053.8 4055.4 4055.8 4085.5 3503.8 3508.9 3511.9 3516.2 3521.3 4869.6 5058.9 5120.5 5190.8 5353.9 3897.0 4360.0 4640.4 4665.9 4726.3 4947.9 4977.0 5655.9 5680.3 5738.6 3696.9 3862.8 3865.3 3886.2 3908.2 4942.6 5198.4 5972.5 5982.5 5983.5 3476.8 3788.3 3910.6 3916.2 3917.4 3245.5 3967.4 3978.3 3980.2 3999.1 3865.3 4146.5 4201.5 4658.7 4683.5 4768.5 5708.2 5715.0 5739.0 5756.8 1145.7 1279.7 1321.9 1360.3 1367.4 855.9 875.5 897.5 901.7 919.2 4758.8 5312.6 5366.6 5373.3 5396.8 4925.8 5397.6 5903.5 5911.8 5961.9 5295.0 5297.9 5318.7 5324.7 5352.6 2958.3 2971.8 3055.8 3064.8 3072.1 5662.3 5933.5 5993.4 6021.8 6042.2 5287.4 5943.2 5951.0 5981.5 6003.4 5619.4 5851.5 6003.8 6085.7 6091.3 4110.6 5235.6 5395.3 5657.7 5928.7 4958.4 5517.4 5647.2 5877.3 5911.7 5056.3 5460.5 5673.4 6144.2 6246.3 3911.2 3948.2 3951.3 3982.1 3984.7 4862.1 5251.0 5999.6 6031.2 6033.9 5305.8 5368.5 5566.6 5755.3 5837.9 5703.2 5745.5 5766.5 5768.3 5770.6 4949.4 5315.2 5356.4 5611.2 5718.0 5037.5 5524.9 5725.5 5757.1 5758.3 4826.6 5326.1 5423.7 5639.9 5669.0 09:26:26 INFO - PROCESS | 1647 | 09:26:26 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:24470.66 Median:3288.18 stddev:39965.90 (1215.4%) stddev-sans-first:40037.80 09:26:26 INFO - PROCESS | 1647 | Values: 589.5 722.6 735.2 766.1 768.0 12283.9 12823.7 12853.2 13179.1 13262.8 12627.6 12635.7 12676.8 12738.5 12761.6 810.2 834.4 834.6 835.1 836.5 660.6 681.9 819.6 848.0 850.4 899.4 899.9 900.5 901.9 902.0 884.6 886.8 887.0 888.0 889.1 510.7 529.1 638.7 660.7 661.8 13595.4 13710.3 13718.4 13720.9 13757.0 12936.4 13157.4 13238.4 13316.1 13845.6 12002.8 12190.6 12276.6 12466.1 12593.8 4062.6 4256.1 4264.3 4310.0 4403.0 111910.0 112836.4 120311.0 120789.8 121507.4 10332.5 10477.5 10631.5 10725.0 10764.9 21001.0 21084.5 21112.0 21125.9 21268.7 6926.1 7022.7 7072.8 7081.6 7163.6 3829.2 3922.0 3935.5 3956.1 3957.6 3173.6 3245.4 3270.7 3305.7 3310.4 628.3 628.8 632.9 635.5 638.4 507.5 527.8 562.5 587.2 592.2 6632.6 7017.5 8301.8 8459.2 8490.8 537.5 576.4 577.8 593.4 594.3 3913.1 4061.8 4071.7 4176.3 4242.1 127029.0 127420.0 163318.0 169773.0 176995.0 124818.0 125277.8 128338.0 132315.0 133266.0 97057.5 104149.0 104381.5 109941.5 111570.0 9188.8 9861.1 9901.8 9966.7 9984.5 52390.0 56628.2 61652.7 63044.7 63460.0 66523.7 83258.0 86112.4 87280.1 90688.0 12660.0 13041.7 13141.5 13236.0 13331.3 14380.8 14415.0 14576.3 14775.0 15008.6 13552.9 13897.4 13926.4 13926.9 14220.4 12654.6 12976.0 13052.9 13418.5 14371.9 13113.7 13506.1 13676.5 13911.8 14077.6 8840.9 11524.1 11739.2 11870.7 11883.5 10262.9 10784.9 11566.1 11643.8 11727.6 09:26:26 INFO - PROCESS | 1647 | -------- Summary: end -------- 09:26:26 INFO - PROCESS | 1647 | 09:26:27 INFO - TEST-INFO | 1647: exit 0 09:26:27 INFO - TEST-OK | dromaeo_css | took 1116207ms 09:26:27 INFO - TEST-START | kraken 09:26:27 INFO - operating with platform_type : mac_ 09:26:27 INFO - Initialising browser for kraken test... 09:26:27 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpCyqVyu/profile http://localhost:49268/getInfo.html) 09:26:29 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 09:26:29 INFO - PROCESS | 1656 | colorDepth:24 09:26:29 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 09:26:29 INFO - PROCESS | 1656 | __metrics 09:26:29 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:26:29 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:26:30 INFO - TEST-INFO | 1656: exit 0 09:26:30 INFO - Browser initialized. 09:26:30 INFO - Running cycle 1/1 for kraken test... 09:26:30 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpCyqVyu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:42 INFO - PROCESS | 1657 | RSS: Main: 219508736 09:26:42 INFO - PROCESS | 1657 | 09:26:44 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 09:26:45 INFO - PROCESS | 1657 | RSS: Main: 269996032 09:26:45 INFO - PROCESS | 1657 | 09:26:48 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 09:26:49 INFO - PROCESS | 1657 | RSS: Main: 280465408 09:26:49 INFO - PROCESS | 1657 | 09:26:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 09:26:52 INFO - PROCESS | 1657 | RSS: Main: 378884096 09:26:52 INFO - PROCESS | 1657 | 09:26:54 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 09:26:55 INFO - PROCESS | 1657 | RSS: Main: 279900160 09:26:55 INFO - PROCESS | 1657 | 09:26:57 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:26:58 INFO - PROCESS | 1657 | RSS: Main: 280248320 09:26:58 INFO - PROCESS | 1657 | 09:27:00 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:01 INFO - PROCESS | 1657 | RSS: Main: 318005248 09:27:01 INFO - PROCESS | 1657 | 09:27:04 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:04 INFO - PROCESS | 1657 | RSS: Main: 317784064 09:27:04 INFO - PROCESS | 1657 | 09:27:07 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 09:27:08 INFO - PROCESS | 1657 | RSS: Main: 316821504 09:27:08 INFO - PROCESS | 1657 | 09:27:09 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:10 INFO - PROCESS | 1657 | RSS: Main: 290344960 09:27:10 INFO - PROCESS | 1657 | 09:27:12 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:12 INFO - PROCESS | 1657 | RSS: Main: 296747008 09:27:12 INFO - PROCESS | 1657 | 09:27:15 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:27:15 INFO - PROCESS | 1657 | RSS: Main: 298344448 09:27:15 INFO - PROCESS | 1657 | 09:27:18 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:27:19 INFO - PROCESS | 1657 | RSS: Main: 316563456 09:27:19 INFO - PROCESS | 1657 | 09:27:22 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:27:22 INFO - PROCESS | 1657 | RSS: Main: 310521856 09:27:22 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 09:27:24 INFO - PROCESS | 1657 | RSS: Main: 354365440 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | __start_tp_report 09:27:24 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 09:27:24 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 09:27:24 INFO - PROCESS | 1657 | |i|pagename|runs| 09:27:24 INFO - PROCESS | 1657 | |0;ai-astar;115;113;112;113;113;112;111;112;111;113 09:27:24 INFO - PROCESS | 1657 | |1;audio-beat-detection;142;108;110;159;139;109;108;107;137;106 09:27:24 INFO - PROCESS | 1657 | |2;audio-dft;183;185;182;184;185;184;179;182;182;182 09:27:24 INFO - PROCESS | 1657 | |3;audio-fft;81;59;58;88;67;60;58;71;106;79 09:27:24 INFO - PROCESS | 1657 | |4;audio-oscillator;84;72;94;70;68;69;92;67;69;89 09:27:24 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;87;85;89;86;89;88;133;117;89;85 09:27:24 INFO - PROCESS | 1657 | |6;imaging-darkroom;94;96;94;95;94;94;99;95;95;95 09:27:24 INFO - PROCESS | 1657 | |7;imaging-desaturate;86;87;86;85;86;85;84;84;84;87 09:27:24 INFO - PROCESS | 1657 | |8;json-parse-financial;59;56;57;58;59;59;59;60;59;58 09:27:24 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;65;78;79;70;73;72;69;69;71;70 09:27:24 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;82;74;82;82;97;97;90;82;82;84 09:27:24 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;139;135;136;153;145;140;141;140;191;126 09:27:24 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;162;161;160;165;160;163;158;162;163;163 09:27:24 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;57;58;59;57;82;85;85;81;66;65 09:27:24 INFO - PROCESS | 1657 | __end_tp_report 09:27:24 INFO - PROCESS | 1657 | __start_cc_report 09:27:24 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,2072 09:27:24 INFO - PROCESS | 1657 | __end_cc_report 09:27:24 INFO - PROCESS | 1657 | __startTimestamp1477326444884__endTimestamp 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | ------- Summary: start ------- 09:27:24 INFO - PROCESS | 1657 | Number of tests: 14 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.18 (1.0%) stddev-sans-first:0.83 09:27:24 INFO - PROCESS | 1657 | Values: 115.0 113.0 112.0 113.0 113.0 112.0 111.0 112.0 111.0 113.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:123.50 stddev:19.63 (15.9%) stddev-sans-first:19.51 09:27:24 INFO - PROCESS | 1657 | Values: 142.0 108.0 110.0 159.0 139.0 109.0 108.0 107.0 137.0 106.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.50 stddev:1.81 (1.0%) stddev-sans-first:1.92 09:27:24 INFO - PROCESS | 1657 | Values: 183.0 185.0 182.0 184.0 185.0 184.0 179.0 182.0 182.0 182.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:72.70 Median:69.00 stddev:15.87 (23.0%) stddev-sans-first:16.55 09:27:24 INFO - PROCESS | 1657 | Values: 81.0 59.0 58.0 88.0 67.0 60.0 58.0 71.0 106.0 79.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.00 stddev:11.00 (14.1%) stddev-sans-first:11.40 09:27:24 INFO - PROCESS | 1657 | Values: 84.0 72.0 94.0 70.0 68.0 69.0 92.0 67.0 69.0 89.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:87.50 stddev:16.43 (18.8%) stddev-sans-first:17.18 09:27:24 INFO - PROCESS | 1657 | Values: 87.0 85.0 89.0 86.0 89.0 88.0 133.0 117.0 89.0 85.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:95.00 stddev:1.52 (1.6%) stddev-sans-first:1.56 09:27:24 INFO - PROCESS | 1657 | Values: 94.0 96.0 94.0 95.0 94.0 94.0 99.0 95.0 95.0 95.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.17 (1.4%) stddev-sans-first:1.22 09:27:24 INFO - PROCESS | 1657 | Values: 86.0 87.0 86.0 85.0 86.0 85.0 84.0 84.0 84.0 87.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.00 stddev:1.17 (2.0%) stddev-sans-first:1.22 09:27:24 INFO - PROCESS | 1657 | Values: 59.0 56.0 57.0 58.0 59.0 59.0 59.0 60.0 59.0 58.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.50 stddev:4.22 (5.9%) stddev-sans-first:3.74 09:27:24 INFO - PROCESS | 1657 | Values: 65.0 78.0 79.0 70.0 73.0 72.0 69.0 69.0 71.0 70.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:83.00 stddev:7.30 (8.8%) stddev-sans-first:7.65 09:27:24 INFO - PROCESS | 1657 | Values: 82.0 74.0 82.0 82.0 97.0 97.0 90.0 82.0 82.0 84.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:140.50 stddev:17.71 (12.6%) stddev-sans-first:18.67 09:27:24 INFO - PROCESS | 1657 | Values: 139.0 135.0 136.0 153.0 145.0 140.0 141.0 140.0 191.0 126.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.50 stddev:2.00 (1.2%) stddev-sans-first:2.12 09:27:24 INFO - PROCESS | 1657 | Values: 162.0 161.0 160.0 165.0 160.0 163.0 158.0 162.0 163.0 163.0 09:27:24 INFO - PROCESS | 1657 | 09:27:24 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:73.50 stddev:12.28 (16.7%) stddev-sans-first:12.16 09:27:24 INFO - PROCESS | 1657 | Values: 57.0 58.0 59.0 57.0 82.0 85.0 85.0 81.0 66.0 65.0 09:27:24 INFO - PROCESS | 1657 | -------- Summary: end -------- 09:27:24 INFO - PROCESS | 1657 | 09:27:25 INFO - TEST-INFO | 1657: exit 0 09:27:25 INFO - TEST-OK | kraken | took 58482ms 09:27:25 INFO - SUITE-END | took 1174s 09:27:26 INFO - Completed test suite (00:19:35) 09:27:26 INFO - javascript benchmark 09:27:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2793.5251007328757, 3322.637718535401, 3375.139339468435, 3384.2385463270753, 3413.4026545354573, 5630.352509461413, 5699.287589051369, 5728.226689396935, 5732.828015159542, 5739.0, 5661.094224924002, 5731.283589551306, 5733.856653583663, 5746.339170995337, 5761.0, 5144.331236939202, 5180.559652429548, 5197.662151960129, 5211.400688920785, 5245.370555533342, 5138.383393992726, 5151.562117220041, 5162.277281180619, 5276.577873770089, 5325.20121981702, 4556.70381425208, 5173.30160428343, 5178.40448348441, 5227.4511176326505, 5240.213967904826, 5144.6655967362185, 5161.638685292031, 5223.268742376071, 5228.4510126436935, 5265.921011184835, 5060.46865079165, 5093.18509038552, 5168.250603662448, 5178.0, 5202.687838729688, 5620.213170156181, 5651.9717401413145, 5653.745581448845, 5676.318841739017, 5726.971365143189, 5753.942460575383, 5775.844831033768, 6186.072089186613, 6297.559170858041, 6333.9683301583655, 6277.497800175975, 6284.458649620474, 6321.6523091229965, 6321.74713011479, 6361.0, 5705.657660540381, 5776.133579963039, 5778.682172480554, 5827.155062515912, 5845.298564172242, 6227.844303892439, 6243.96878015607, 6259.561830671901, 6260.123582698426, 6276.466500347522, 6188.845278867974, 6217.906731399033, 6234.75060997555, 6238.157848690369, 6240.625562466266, 6112.74665817949, 6180.6600636965395, 6215.34738852414, 6270.059491076375, 6300.432961033437, 6196.194494715748, 6255.999040153553, 6258.374162583706, 6270.372962703785, 6282.685865706696, 6248.843778905563, 6273.8745225095245, 6273.937260627426, 6291.213598300213, 6303.0, 4865.659403841697, 4910.435299940481, 4987.351644286219, 4991.975040124848, 5009.398872135367, 4426.402435671208, 4471.8434854779925, 4475.239209334356, 4476.955230447719, 4493.505714371417, 5835.854103647443, 5841.41585841421, 5861.677607731615, 5862.0, 5864.149698293723, 6273.65494897785, 6278.4035516625845, 6292.559520833589, 6305.117283580303, 6320.4311611955145, 5619.297587801525, 5725.51333136688, 5736.0, 5747.885042299215, 5811.651300921958, 5426.158945363475, 5450.482204190595, 5459.563234941195, 5463.153211252262, 5472.151816468454, 6362.809115726535, 6365.140706004723, 6374.0, 6380.298167201604, 6400.295967443578, 6116.510679145568, 6207.037909124093, 6215.378462153749, 6280.874382512416, 6352.078948552342, 6223.159873417212, 6251.906221406592, 6260.74957001733, 6342.39747224013, 6369.8726025480155, 5242.580593552583, 6209.534284928558, 6258.874822503615, 6266.68666566679, 6280.183576135073, 6239.344868788712, 6244.594101383395, 6246.3441338660605, 6305.716242768995, 6332.746690132343, 5761.884762304814, 5966.671833049224, 6061.545384096298, 6079.1793107931635, 6105.664188469676, 6154.446099851035, 6165.568410211242, 6171.105189747372, 6179.196704428396, 6188.44304012623, 5898.793542226002, 5996.820095397145, 6024.638521688713, 6046.486048685735, 6056.848578785565, 5986.640801551921, 6077.696115194134, 6098.695065246809, 6121.143039974496, 6175.073738939195, 6055.182550355646, 6071.119687645179, 6071.726772295169, 6090.573659843945, 6091.360407157184], "value": 5709.552708633946, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.89712160446305, 519.8206618716542, 524.1613418530352, 545.2393910494862, 558.193410521796, 32451.02646920593, 39890.80054599726, 40816.795916020455, 41036.79481602592, 43263.0, 42943.57056429435, 42979.0, 43258.48595299165, 43299.78350108245, 43376.566234337646, 9789.804203915899, 9961.053699898534, 9968.900310996905, 9975.551100200471, 9976.002399760002, 8755.693550725726, 9003.639854405816, 12003.0, 12245.938770306137, 12288.139830211889, 12269.44787484561, 12355.814662780065, 12366.258024518558, 12375.257484550955, 12377.876221237762, 12201.877981220163, 12273.815892761615, 12288.324142172178, 12289.56986505468, 12306.015518758522, 12082.879171208351, 12143.02855771536, 12147.757044859141, 12157.756844863141, 12159.452824622826, 40638.0, 40884.97787555335, 40944.0, 40950.38574421386, 40968.59031409678, 3370.4775759757276, 3524.400851855165, 3558.19940513385, 3586.605473397924, 3812.4471951567143, 29960.550591741143, 30939.84530077335, 31058.378832423226, 31313.843430782927, 32372.514412283836, 3126.171564535377, 3139.262273365757, 3146.5594816725675, 3211.71094601487, 3275.0, 520251.0, 522936.0, 524782.376088121, 526274.0, 526649.0, 62521.68739156275, 62951.6852415735, 62998.68500657559, 63071.36928630747, 63110.36889631045, 34309.656903430645, 34665.30669386598, 34795.13012174665, 36482.81758591243, 65386.346136538974, 16757.07836069028, 16889.408870689465, 16907.577310567332, 16909.7463538047, 16912.408065717642, 11618.825717614243, 11849.526018959144, 12927.676808079874, 13004.479820807252, 13030.609081727564, 19289.035548222815, 19349.03254837281, 19586.608267834563, 19898.801011989985, 20055.899720501595, 6925.411340036053, 7046.260142685047, 7202.099737532809, 7587.696492140363, 8052.396070294752, 866.7139843851514, 932.5197523275518, 959.3524371049514, 970.1705042188968, 1069.769999450122, 28910.132696019155, 29775.0, 29941.0, 30574.0, 30699.386012280076, 960.4525420510242, 1099.3294090604725, 1135.971600709989, 1138.174823253135, 1138.3113216504062, 15529.922350388175, 15572.766408503881, 15618.68762624741, 15694.686106278039, 15938.36246550125, 694964.0, 702030.0, 702513.0, 702701.0, 704539.0, 48125.51874481211, 58401.123983140285, 58909.0, 59145.70427147837, 59212.11181832276, 1256.5727652597977, 1282.6665067082627, 1380.061558140434, 1402.558194168854, 1414.3988804757937, 29403.41193176167, 30695.386092278477, 30973.690263097982, 31111.68888311088, 31823.0, 50070.749646251534, 50577.49422505728, 50580.0, 50640.0, 50642.74678626583, 520408.0, 523209.0, 523625.0, 525234.0, 525441.0, 26735.0, 27503.86248068827, 27539.72460275452, 28398.43203135967, 28414.289642759097, 47480.762596186796, 47745.0, 47977.04045919132, 48131.518684812705, 48217.517824821305, 33028.34455274159, 39015.60984390233, 39124.41313380359, 39628.80185599169, 40523.0, 38686.80656596699, 39448.605513944494, 40527.0, 40585.39121913115, 40633.39049914195, 37525.62474375221, 37647.81176094102, 37679.81160094182, 37915.86252412432, 37934.430983534716, 32723.34553308968, 34145.14637133992, 34511.65488345185, 34794.82602586971, 34899.65100349065, 25566.488670226863, 25666.74333256718, 25855.756407246285, 25940.870295649154, 25997.870010649825], "value": 20461.366889652727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.7669408108404, 341.5832684125367, 352.20401891724697, 361.31711066085103, 398.6770715720267, 15239.542813715592, 15527.534173974771, 16360.754588681164, 20918.163273469043, 21204.833734144653, 19647.0, 20067.698984515206, 20559.8692071936, 20951.266705665304, 21432.785672143273, 5893.322267939177, 5910.763569457216, 6162.537809664271, 6163.938360616404, 6180.505559555248, 4635.58279754822, 6058.727357268934, 6115.48018418435, 6126.326104128542, 6132.233470816148, 5828.795992140276, 5986.640801551899, 6109.541784366168, 6111.633302001894, 6114.785982490614, 5874.236349274588, 6034.215551978258, 6082.300535438437, 6087.6956152192215, 6105.41998510143, 5090.465501122366, 5290.841274761763, 5291.920621190685, 5521.337439507285, 5589.692566908819, 13127.934360328138, 13404.396802143927, 13406.93296533511, 15945.601359965978, 25153.748462515323, 2227.20934068405, 2309.3880121767743, 2367.2661474942824, 2374.726906405751, 2568.2166939083572, 10032.097111260022, 10475.1096156826, 10515.684529464128, 10757.784844303149, 11085.060114480015, 1592.864606508448, 1692.7642820740928, 1793.2199493220492, 1826.8447181989548, 1830.066666000336, 121248.39375803065, 122577.0, 125758.3712081443, 128839.06741398887, 129212.3539382297, 11096.667099987013, 11223.551057957753, 11395.544178232778, 11611.76776464466, 11761.88238117625, 14529.418823247162, 14530.854691453162, 14544.200068996095, 14547.27263636814, 14559.3448294827, 8402.201790829862, 8634.740957771277, 8642.265407440313, 8747.431416958005, 8754.56227188638, 8639.524826134497, 8651.48091114535, 8667.0, 8808.911910880937, 8859.0, 4394.560543945579, 4482.350059241457, 4495.303227999665, 4555.612772914273, 4575.313702944585, 1892.9053547322578, 1894.5737209128113, 1908.4560900143392, 1916.7891531931477, 1963.1165975310882, 828.6975254032355, 916.1022198245756, 996.1433167475965, 1006.0141061759516, 1006.8691070160833, 17805.198766055557, 19313.51716207078, 19809.306674266332, 21103.17495969543, 21438.785612143678, 914.6387177065022, 927.3369540778376, 947.6351604632266, 990.7374545745383, 1022.4121130350078, 10223.284370094021, 10835.51240194193, 10848.132149428027, 10856.0, 10867.29362591429, 560131.0, 571288.0, 576512.0, 580283.0, 592991.0, 89338.55330723304, 90161.0, 94892.0, 121454.0, 128596.0, 862.4135587800356, 912.4388501071926, 968.1915600473543, 972.7568107973007, 977.0864241933815, 18871.811281887007, 19187.424377268704, 19241.711374329116, 19434.90282548578, 19474.0, 46650.0, 46825.76587117043, 47227.34704285333, 52652.0, 53253.0, 67800.0, 68652.656736716, 69319.0, 71166.64416677883, 74801.87797183155, 7159.284071592799, 7705.922940770521, 7880.84238315242, 8034.63844127004, 8160.347172226327, 11625.534978600761, 12514.249145051326, 12575.245485270912, 12756.936215318863, 13016.609501714964, 11085.27945683528, 11282.53327067476, 11308.0, 11334.773304534028, 11352.602658906899, 9588.856167157637, 10824.945875270574, 10983.83524247121, 11186.216964812385, 11390.0, 9237.445753254826, 11131.55473781072, 11261.943690281823, 11622.0702343814, 11650.242734222249, 6583.407493325623, 7063.788086357417, 7322.743703970548, 7329.633518323956, 7466.0, 9375.10936461035, 10863.511141998788, 11100.444977750918, 11311.717207069889, 11393.943030284796], "value": 9267.770981826228, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.3960477192422, 1502.0, 1685.4522280258911, 1825.497988053286, 1888.848892088633, 8512.616932238048, 9043.276537876962, 9056.456612603248, 9059.275257979361, 9067.909320906789, 7830.29527342539, 8087.9191208087905, 8110.635021424036, 8568.0, 8752.431091979017, 2161.427221786228, 2374.2639781667654, 2390.725066617344, 2425.4785221177444, 2427.9393015174587, 2375.5248950210025, 2390.8087353011806, 2427.78149966503, 2434.9878250608813, 2435.902563897442, 1914.5117994911277, 2111.567128738605, 2190.8904554772275, 2272.545490901818, 2351.318117745852, 2403.098837935774, 2423.285130886375, 2425.34515680767, 2426.5389575980507, 2429.8663573503363, 2384.5826980278557, 2415.1909110448023, 2416.1905761569897, 2416.5166966606575, 2422.7456117107804, 8928.508932008737, 9015.819683606356, 9033.638654453815, 9035.683751068747, 9051.547422628842, 5282.7622756976025, 5384.40771515133, 5445.700486473243, 5446.564274858002, 5453.7818487260465, 3370.646082161387, 3414.4878268259713, 3485.790852548855, 3558.946615800765, 3566.7859928404378, 1008.9293749437543, 1010.3432768700403, 1023.053675350298, 1024.7694268789537, 1032.5818043692316, 11942.582009629708, 11944.522219111224, 11947.522099116024, 11966.401679916056, 12014.339211343373, 4522.208613492691, 4870.172070747911, 4915.5330243626795, 4917.680350777188, 4938.58022068121, 10122.240831937634, 10128.240381971234, 10132.949335253277, 10147.137493313152, 10168.898311016943, 5396.568274538027, 5422.566194704415, 5427.0773968425465, 5433.185022246695, 5437.45625437461, 4800.399950006249, 4882.829100981448, 4973.577245934136, 4976.776045077981, 4992.700437973734, 3449.6377880322207, 3966.6231707987695, 3999.440078389028, 4087.346024636044, 4111.383292506088, 1282.224254326138, 1289.1620446709715, 1295.33290355467, 1310.2989900403238, 1312.4618906248393, 622.9067985685184, 759.0928840036104, 789.1280135450245, 855.9486430814171, 931.4830269200659, 5795.420457954171, 5799.217105690762, 5857.0, 6071.817845464643, 6134.957057300269, 856.2122846980793, 915.2997956563235, 921.1433366968784, 968.1963969904962, 983.095552092077, 3833.9424908626393, 3920.843166273374, 3959.4852669152824, 3965.0285680008583, 4063.6342729153926, 10437.165026797838, 10543.314684545634, 10812.405317707602, 10987.39569323695, 11010.339379637247, 10893.07408870255, 10900.291481053706, 10927.453627318602, 10929.0, 10946.343219406703, 8134.837303253902, 8238.134995825472, 8270.710525131592, 8380.413371063967, 8418.368622353226, 5610.551155907599, 5846.298444186725, 5847.06446968483, 5896.380880007538, 5958.433948774859, 9968.950155249177, 10106.444145572064, 10272.640457583948, 10276.640317588848, 10282.845757313797, 9788.0, 10192.847107293248, 10479.214058945761, 10486.94756526243, 10488.94755526248, 7484.32641062307, 7575.507592006502, 7580.1661817198965, 7588.127365353055, 7616.961915190389, 8313.002439707274, 8403.663853446038, 8410.327173825957, 8411.831763364577, 8421.873671894804, 7360.852782944418, 7477.439192060726, 7519.699212031457, 7519.887201692089, 7521.360684341674, 7320.487565870338, 7387.852242955003, 7388.889166662612, 7415.851682966419, 7436.107667079985, 6931.133608298963, 7071.7878463646175, 7072.398846098139, 7076.823079423056, 7081.008658787877, 4438.689291749675, 4896.706197628011, 5015.821281998655, 5025.522575355335, 5070.062038522885, 4854.490278520846, 4944.6785958914, 5009.0, 5102.821401251087, 5193.0652482552], "value": 4606.183564792123, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.4322086762114, 299.49236044903887, 304.15445062725615, 306.9232691827043, 308.434023566755, 5427.0773968425365, 5452.737114097649, 5469.0, 5482.889087701229, 5500.339959204891, 4523.886902827431, 5082.390113186413, 5183.734247424127, 5283.735813209334, 5352.866178345544, 3494.860205591773, 3584.7132229421713, 4080.7347522411096, 4135.855245066431, 4173.582641735818, 3653.19629681471, 3681.337359275329, 4054.1148366009797, 4141.813618387165, 4171.520275168364, 3396.507506411569, 3424.7773894696766, 3863.7681739095606, 4044.9078748737825, 4118.979405102985, 4052.4326594276827, 4053.837846486137, 4055.4322394864744, 4055.817488213023, 4085.46888904442, 3503.789772613651, 3508.894663202084, 3511.877084302063, 3516.226430185355, 3521.295740851814, 4869.561739443467, 5058.873528161788, 5120.539151476385, 5190.806114593627, 5353.946460535384, 3896.961030389688, 4359.956400435986, 4640.396748422717, 4665.86002419928, 4726.26742854858, 4947.901041979177, 4977.0, 5655.943440565583, 5680.318361796611, 5738.569607279429, 3696.9260614787822, 3862.7875466849314, 3865.2849222893856, 3886.24218277436, 3908.17928235071, 4942.629302802268, 5198.350206224222, 5972.492338151219, 5982.4914882234625, 5983.521318294526, 3476.80877551732, 3788.299164654548, 3910.608939106067, 3916.1971795781797, 3917.3928041153667, 3245.545623612696, 3967.4048892665755, 3978.264021156095, 3980.20395920817, 3999.0604556789935, 3865.2556684753577, 4146.523149837807, 4201.516825565099, 4658.743769092733, 4683.484816670163, 4768.546988036201, 5708.175522400002, 5715.0, 5738.962668252793, 5756.769729210785, 1145.7021174494525, 1279.680079980005, 1321.8612045735251, 1360.2996254681648, 1367.43934986655, 855.9015713193063, 875.487839613833, 897.4794619121025, 901.6799036342135, 919.1911118215927, 4758.833440829623, 5312.62811603184, 5366.6243362965, 5373.2746079278795, 5396.811111611075, 4925.802967881316, 5397.595180361489, 5903.527717782567, 5911.847189797948, 5961.940380596226, 5294.973525132426, 5297.920531192035, 5318.65428747138, 5324.722066704041, 5352.635078055071, 2958.349163184096, 2971.7919745618033, 3055.816651000947, 3064.8161110333454, 3072.0799500312305, 5662.348829884533, 5933.525317974551, 5993.370696076936, 6021.819345419644, 6042.160184713178, 5287.41838397776, 5943.167956486009, 5951.0, 5981.491573216325, 6003.3996600339615, 5619.438056194348, 5851.531877449709, 6003.849903752353, 6085.726142323606, 6091.269047714302, 4110.636384079106, 5235.581153507634, 5395.271638328775, 5657.717114144194, 5928.733207005609, 4958.404991401055, 5517.393086760373, 5647.15292706081, 5877.265341832271, 5911.733971971185, 5056.342675452168, 5460.453954604508, 5673.404292549223, 6144.2319710036245, 6246.250449946036, 3911.159100793343, 3948.2103579283685, 3951.2887680217837, 3982.143839074613, 3984.681225502011, 4862.124817532878, 5250.973745131403, 5999.620087380014, 6031.24609423822, 6033.879322413615, 5305.806193606562, 5368.476815896523, 5566.610337276514, 5755.309362876482, 5837.949169149424, 5703.230063941315, 5745.482906538432, 5766.538676905921, 5768.307803063659, 5770.64389868389, 4949.356583644248, 5315.182953034898, 5356.437574054668, 5611.214429979887, 5717.971410142923, 5037.481259370315, 5524.944750552443, 5725.51333136688, 5757.107648314518, 5758.3090029196765, 4826.61387089025, 5326.147816349366, 5423.728813559385, 5639.915401269066, 5668.967102600089], "value": 4122.170036684994, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.498925912974, 722.5664601239254, 735.2280105888815, 766.0615745711505, 767.9961600191998, 12283.938580307096, 12823.679408014805, 12853.164544304625, 13179.07746457746, 13262.801057984138, 12627.621171364874, 12635.747285054293, 12676.80984785229, 12738.490460381598, 12761.617151485447, 810.1655295046112, 834.4159088637947, 834.6035633074272, 835.0980940584185, 836.481381543444, 660.6102399584245, 681.924988251292, 819.647551552832, 847.9703210387606, 850.3962186847315, 899.4378513429107, 899.8695189197563, 900.4507250577143, 901.900790912999, 902.0213068820337, 884.60192913189, 886.8004698942751, 886.9556522173898, 887.951162686052, 889.1064480197425, 510.6884800271831, 529.055635690291, 638.7157714816908, 660.6663634864411, 661.8047675935611, 13595.388207530685, 13710.314484275747, 13718.38267277975, 13720.862791372057, 13757.0, 12936.353182340845, 13157.407916643773, 13238.404271807793, 13316.134451260734, 13845.584632461043, 12002.819957700642, 12190.57332993341, 12276.570320038845, 12466.127371084027, 12593.811092833615, 4062.614051665087, 4256.148770245933, 4264.253755592759, 4309.956900430987, 4403.031333106712, 111910.0, 112836.43581782038, 120311.0, 120789.77235796793, 121507.39246303712, 10332.535035923402, 10477.47612619366, 10631.46842657864, 10725.03474687282, 10764.946175269073, 21001.0, 21084.47288817792, 21112.0, 21125.9437028148, 21268.680969785466, 6926.134233220848, 7022.683979220948, 7072.823179420556, 7081.645917704094, 7163.606001669854, 3829.195868867513, 3921.9998900280816, 3935.4883865097354, 3956.050547868548, 3957.584453632385, 3173.6032995875516, 3245.432049391347, 3270.705636492727, 3305.652906444837, 3310.354480876206, 628.3119983617931, 628.7862126876884, 632.8955722305768, 635.5328833307515, 638.4317957018258, 507.47476361965187, 527.8310940499081, 562.5134258866133, 587.2014060877203, 592.1591340296789, 6632.568883022588, 7017.47368947331, 8301.792455188668, 8459.154084591491, 8490.830183396298, 537.4705914674043, 576.3890276307128, 577.8208755285875, 593.403629352498, 594.3373138950126, 3913.099987003005, 4061.756294622332, 4071.714979951434, 4176.331786914079, 4242.087951090531, 127029.0, 127420.0, 163318.0, 169773.0, 176995.0, 124818.0, 125277.8347139678, 128338.0, 132315.0, 133266.0, 97057.544136838, 104148.95851041544, 104381.47809261057, 109941.45029274962, 111570.0, 9188.783925625978, 9861.112499875046, 9901.801963960825, 9966.651167209113, 9984.500774961369, 52390.0, 56628.15057774054, 61652.69173654103, 63044.68477657582, 63460.04809927762, 66523.67810575239, 83258.0, 86112.4026938247, 87280.1271987272, 90688.0, 12660.0, 13041.673958151123, 13141.474341026253, 13236.007299452773, 13331.266780327174, 14380.784288235476, 14414.972855700002, 14576.34406451691, 14775.039622424509, 15008.624784380478, 13552.93223533876, 13897.444102236203, 13926.39846417675, 13926.860731392557, 14220.431182752574, 12654.557090501788, 12976.02679799, 13052.869471305545, 13418.530351437652, 14371.85628143747, 13113.672158196121, 13506.122102063728, 13676.452941882213, 13911.791323130363, 14077.648058798612, 8840.867386989328, 11524.078073753912, 11739.23694959825, 11870.703232419259, 11883.465244063866, 10262.89610629834, 10784.91903841917, 11566.132540059698, 11643.825342620037, 11727.589534366256], "value": 7501.497914900246, "unit": "score"}], "name": "dromaeo_css", "value": 7323.109039471577, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 112.0, 113.0, 113.0, 112.0, 111.0, 112.0, 111.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 110.0, 159.0, 139.0, 109.0, 108.0, 107.0, 137.0, 106.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 182.0, 184.0, 185.0, 184.0, 179.0, 182.0, 182.0, 182.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 88.0, 67.0, 60.0, 58.0, 71.0, 106.0, 79.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 94.0, 70.0, 68.0, 69.0, 92.0, 67.0, 69.0, 89.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 86.0, 89.0, 88.0, 133.0, 117.0, 89.0, 85.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 94.0, 94.0, 99.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 85.0, 86.0, 85.0, 84.0, 84.0, 84.0, 87.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 57.0, 58.0, 59.0, 59.0, 59.0, 60.0, 59.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 78.0, 79.0, 70.0, 73.0, 72.0, 69.0, 69.0, 71.0, 70.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 82.0, 82.0, 97.0, 97.0, 90.0, 82.0, 82.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 135.0, 136.0, 153.0, 145.0, 140.0, 141.0, 140.0, 191.0, 126.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 165.0, 160.0, 163.0, 158.0, 162.0, 163.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 57.0, 82.0, 85.0, 85.0, 81.0, 66.0, 65.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1434.1999999999998, "alertThreshold": 2.0}]} 09:27:26 INFO - Return code: 0 09:27:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:27:26 INFO - # TBPL SUCCESS # 09:27:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:27:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:27:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:27:26 INFO - 2016-10-24 09:27:26.224 screenresolution[1661:9729] starting screenresolution argv=screenresolution get 09:27:26 INFO - 2016-10-24 09:27:26.227 screenresolution[1661:9729] Display 0: 1600x1200x32@60 09:27:26 INFO - 2016-10-24 09:27:26.233 screenresolution[1662:9732] starting screenresolution argv=screenresolution list 09:27:26 INFO - Available Modes on Display 0 09:27:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:27:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:27:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:27:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:27:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:27:26 INFO - Intel Iris: 09:27:26 INFO - Chipset Model: Intel Iris 09:27:26 INFO - Type: GPU 09:27:26 INFO - Bus: Built-In 09:27:26 INFO - VRAM (Dynamic, Max): 1536 MB 09:27:26 INFO - Vendor: Intel (0x8086) 09:27:26 INFO - Device ID: 0x0a2e 09:27:26 INFO - Revision ID: 0x0009 09:27:26 INFO - Displays: 09:27:26 INFO - Display: 09:27:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:27:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:27:26 INFO - Display Serial Number: 1600x1200 60 09:27:26 INFO - Main Display: Yes 09:27:26 INFO - Mirror: Off 09:27:26 INFO - Online: Yes 09:27:26 INFO - Rotation: Supported 09:27:26 INFO - Return code: 0 09:27:26 INFO - Running post-action listener: _resource_record_post_action 09:27:26 INFO - [mozharness: 2016-10-24 16:27:26.468125Z] Finished run-tests step (success) 09:27:26 INFO - Running post-run listener: _resource_record_post_run 09:27:26 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37491712; Write bytes: 663177728; Read time: 244; Write time: 1860 09:27:26 INFO - TinderboxPrint: CPU usage
53.4% 09:27:26 INFO - TinderboxPrint: I/O read bytes / time
37,491,712 / 244 09:27:26 INFO - TinderboxPrint: I/O write bytes / time
663,177,728 / 1,860 09:27:26 INFO - TinderboxPrint: CPU idle
2,254.7 (46.6%) 09:27:26 INFO - TinderboxPrint: CPU system
968.1 (20.0%) 09:27:26 INFO - TinderboxPrint: CPU user
1,610.8 (33.3%) 09:27:26 INFO - TinderboxPrint: Swap in / out
400,789,504 / 0 09:27:26 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 355553792; Write bytes: 357058560; Read time: 27752; Write time: 730 09:27:26 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 36520960; Write bytes: 295932416; Read time: 228; Write time: 1094 09:27:26 INFO - Running post-run listener: _upload_blobber_files 09:27:26 INFO - Blob upload gear active. 09:27:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:27:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:27:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:27:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:27:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:27:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:28 INFO - (blobuploader) - INFO - Done attempting. 09:27:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:27:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:27:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:29 INFO - (blobuploader) - INFO - Done attempting. 09:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:27:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:31 INFO - (blobuploader) - INFO - Done attempting. 09:27:31 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:31 INFO - Return code: 0 09:27:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d40036dc8a486ef6b36ebed4bf5fde22796fee7d5c505aa6a0bcedddcd5d69e63d90095e6d229dbab6cd51ce172254001e8ca56f92ae67b47e67591f39cb2e8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/478e8add85e36f19eada6102f1a23e687407ba31df9f536f783653a615fc8c1f5375dfad4491f1cf16877a0068ad180e308fe5607cfaf3b366ff2f639fba9e75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3de939f740c44c97cc2bd54d5c61b0ec8b55ceb102dc1e2010d483f2ee6d21e3684714b32b53b26f63dd35ea6f7b67aa68c40374a95acf2f8bd2dd29f7833efc"} 09:27:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:31 INFO - Contents: 09:27:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d40036dc8a486ef6b36ebed4bf5fde22796fee7d5c505aa6a0bcedddcd5d69e63d90095e6d229dbab6cd51ce172254001e8ca56f92ae67b47e67591f39cb2e8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/478e8add85e36f19eada6102f1a23e687407ba31df9f536f783653a615fc8c1f5375dfad4491f1cf16877a0068ad180e308fe5607cfaf3b366ff2f639fba9e75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3de939f740c44c97cc2bd54d5c61b0ec8b55ceb102dc1e2010d483f2ee6d21e3684714b32b53b26f63dd35ea6f7b67aa68c40374a95acf2f8bd2dd29f7833efc"} 09:27:31 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:31 INFO - Copying logs to upload dir... 09:27:31 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.033180 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-24 09:27:31.736026) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 09:27:31.739425) ========= 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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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/d40036dc8a486ef6b36ebed4bf5fde22796fee7d5c505aa6a0bcedddcd5d69e63d90095e6d229dbab6cd51ce172254001e8ca56f92ae67b47e67591f39cb2e8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/478e8add85e36f19eada6102f1a23e687407ba31df9f536f783653a615fc8c1f5375dfad4491f1cf16877a0068ad180e308fe5607cfaf3b366ff2f639fba9e75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3de939f740c44c97cc2bd54d5c61b0ec8b55ceb102dc1e2010d483f2ee6d21e3684714b32b53b26f63dd35ea6f7b67aa68c40374a95acf2f8bd2dd29f7833efc"} build_url:https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010907 build_url: 'https://queue.taskcluster.net/v1/task/aaQhJgb-QCG1WZ83rAtHdg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d40036dc8a486ef6b36ebed4bf5fde22796fee7d5c505aa6a0bcedddcd5d69e63d90095e6d229dbab6cd51ce172254001e8ca56f92ae67b47e67591f39cb2e8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/478e8add85e36f19eada6102f1a23e687407ba31df9f536f783653a615fc8c1f5375dfad4491f1cf16877a0068ad180e308fe5607cfaf3b366ff2f639fba9e75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3de939f740c44c97cc2bd54d5c61b0ec8b55ceb102dc1e2010d483f2ee6d21e3684714b32b53b26f63dd35ea6f7b67aa68c40374a95acf2f8bd2dd29f7833efc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 09:27:31.771144) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:27:31.771455) ========= 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.lGfzlOHHMO/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.gWtCgo0xmF/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.005070 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:27:31.819878) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 09:27:31.820204) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 09:27:31.820576) ========= ========= Total master_lag: 1.72 =========