builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0267 starttime: 1475330385.48 results: success (0) buildid: 20161001055157 builduid: 4324b635eb2641f3aa55a491c5ddd022 revision: cd209acf4fb537c08788b69bf1c93370becee0d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:45.478262) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:45.478648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:45.478933) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:45.510580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:45.510863) ========= 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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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-01 06:59:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-10-01 06:59:45 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.490284 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:46.033086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:46.033369) ========= 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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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.027013 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:46.081647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 06:59:46.082011) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cd209acf4fb537c08788b69bf1c93370becee0d2 --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 cd209acf4fb537c08788b69bf1c93370becee0d2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7C6mgvm5gv/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.SEFcX5zgx3/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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-01 06:59:46,156 truncating revision to first 12 chars 2016-10-01 06:59:46,157 Setting DEBUG logging. 2016-10-01 06:59:46,157 attempt 1/10 2016-10-01 06:59:46,157 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cd209acf4fb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 06:59:46,983 unpacking tar archive at: mozilla-aurora-cd209acf4fb5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.115842 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 06:59:47.219275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:47.219576) ========= script_repo_revision: cd209acf4fb537c08788b69bf1c93370becee0d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:47.219980) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:47.220303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:47.238125) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-01 06:59:47.238513) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 06:59:47 INFO - MultiFileLogger online at 20161001 06:59:47 in /builds/slave/test 06:59:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:59:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:59:47 INFO - {'append_to_log': False, 06:59:47 INFO - 'base_work_dir': '/builds/slave/test', 06:59:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:59:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:59:47 INFO - 'branch': 'Mozilla-Aurora', 06:59:47 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:47 INFO - 'config_files': ('talos/mac_config.py',), 06:59:47 INFO - 'default_actions': ('clobber', 06:59:47 INFO - 'read-buildbot-config', 06:59:47 INFO - 'download-and-extract', 06:59:47 INFO - 'populate-webroot', 06:59:47 INFO - 'create-virtualenv', 06:59:47 INFO - 'install', 06:59:47 INFO - 'run-tests'), 06:59:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:47 INFO - 'download_minidump_stackwalk': True, 06:59:47 INFO - 'download_symbols': 'ondemand', 06:59:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:47 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:47 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:47 INFO - 'installer_path': 'installer.exe', 06:59:47 INFO - 'log_level': 'info', 06:59:47 INFO - 'log_name': 'talos', 06:59:47 INFO - 'log_to_console': True, 06:59:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:59:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:59:47 INFO - 'opt_config_files': (), 06:59:47 INFO - 'pip_index': False, 06:59:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:59:47 INFO - 'cmd': ('bash', 06:59:47 INFO - '-c', 06:59:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:59:47 INFO - 'enabled': True, 06:59:47 INFO - 'halt_on_failure': False, 06:59:47 INFO - 'name': 'check_screen_resolution'},), 06:59:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:59:47 INFO - 'cmd': ('bash', 06:59:47 INFO - '-c', 06:59:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:59:47 INFO - 'enabled': True, 06:59:47 INFO - 'halt_on_failure': False, 06:59:47 INFO - 'name': 'check_screen_resolution'},), 06:59:47 INFO - 'run_cmd_checks_enabled': True, 06:59:47 INFO - 'sps_profile': False, 06:59:47 INFO - 'sps_profile_interval': 0, 06:59:47 INFO - 'suite': 'dromaeojs-e10s', 06:59:47 INFO - 'system_bits': '32', 06:59:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:47 INFO - 'title': 't-yosemite-r7-0267', 06:59:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:47 INFO - 'use_talos_json': True, 06:59:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:59:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:47 INFO - 'work_dir': 'build'} 06:59:47 INFO - [mozharness: 2016-10-01 13:59:47.436622Z] Running clobber step. 06:59:47 INFO - Running pre-action listener: _resource_record_pre_action 06:59:47 INFO - Running main action method: clobber 06:59:47 INFO - rmtree: /builds/slave/test/build 06:59:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:59:49 INFO - Running post-action listener: _resource_record_post_action 06:59:49 INFO - [mozharness: 2016-10-01 13:59:49.554606Z] Finished clobber step (success) 06:59:49 INFO - [mozharness: 2016-10-01 13:59:49.554718Z] Running read-buildbot-config step. 06:59:49 INFO - Running pre-action listener: _resource_record_pre_action 06:59:49 INFO - Running main action method: read_buildbot_config 06:59:49 INFO - Using buildbot properties: 06:59:49 INFO - { 06:59:49 INFO - "project": "", 06:59:49 INFO - "product": "firefox", 06:59:49 INFO - "script_repo_revision": "production", 06:59:49 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 06:59:49 INFO - "repository": "", 06:59:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 06:59:49 INFO - "buildid": "20161001055157", 06:59:49 INFO - "pgo_build": "False", 06:59:49 INFO - "basedir": "/builds/slave/test", 06:59:49 INFO - "buildnumber": 5, 06:59:49 INFO - "slavename": "t-yosemite-r7-0267", 06:59:49 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:59:49 INFO - "platform": "yosemite_r7", 06:59:49 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:59:49 INFO - "branch": "mozilla-aurora", 06:59:49 INFO - "repo_path": "releases/mozilla-aurora", 06:59:49 INFO - "revision": "cd209acf4fb537c08788b69bf1c93370becee0d2", 06:59:49 INFO - "stage_platform": "macosx64", 06:59:49 INFO - "builduid": "4324b635eb2641f3aa55a491c5ddd022", 06:59:49 INFO - "slavebuilddir": "test" 06:59:49 INFO - } 06:59:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 06:59:49 INFO - Running post-action listener: _resource_record_post_action 06:59:49 INFO - [mozharness: 2016-10-01 13:59:49.557538Z] Finished read-buildbot-config step (success) 06:59:49 INFO - [mozharness: 2016-10-01 13:59:49.557635Z] Running download-and-extract step. 06:59:49 INFO - Running pre-action listener: _resource_record_pre_action 06:59:49 INFO - Running main action method: download_and_extract 06:59:49 INFO - mkdir: /builds/slave/test/build/tests 06:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:49 INFO - trying https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 06:59:49 INFO - Downloading https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/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 06:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/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 06:59:51 INFO - Downloaded 1199 bytes. 06:59:51 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 06:59:51 INFO - Using the following test package requirements: 06:59:51 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:59:51 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 06:59:51 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 06:59:51 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'jsshell-mac.zip'], 06:59:51 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 06:59:51 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:59:51 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 06:59:51 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 06:59:51 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 06:59:51 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 06:59:51 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:59:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:59:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:59:51 INFO - Fetch https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:59:51 INFO - Expected file size: 16433741 06:59:58 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 06:59:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:59:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:59:58 INFO - Fetch https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:59:58 INFO - Expected file size: 16433741 07:00:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:00:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:00:05 INFO - Fetch https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:00:06 INFO - Expected file size: 14414059 07:00: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')]} 07:00:06 INFO - trying https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:00:06 INFO - Downloading https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:00:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/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 07:00:09 INFO - Downloaded 115275146 bytes. 07:00:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:00:09 INFO - mkdir: /builds/slave/test/properties 07:00:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:00:09 INFO - Writing to file /builds/slave/test/properties/build_url 07:00:09 INFO - Contents: 07:00:09 INFO - build_url:https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:00:11 INFO - Running post-action listener: _resource_record_post_action 07:00:11 INFO - Running post-action listener: set_extra_try_arguments 07:00:11 INFO - [mozharness: 2016-10-01 14:00:11.180135Z] Finished download-and-extract step (success) 07:00:11 INFO - [mozharness: 2016-10-01 14:00:11.180256Z] Running populate-webroot step. 07:00:11 INFO - Running pre-action listener: _resource_record_pre_action 07:00:11 INFO - Running main action method: populate_webroot 07:00:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:11 INFO - '--tppagecycles', 07:00:11 INFO - '7'], 07:00:11 INFO - 'tests': ['tsvgm']}}, 07:00:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:00:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:00:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:00:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['damp', 'tps']}, 07:00:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'tests': ['damp', 'tps']}, 07:00:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['dromaeo_dom']}, 07:00:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['basic_compositor_video']}, 07:00:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:00:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other-e10s': {'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tsvgx', 07:00:11 INFO - 'tsvgr_opacity', 07:00:11 INFO - 'tart', 07:00:11 INFO - 'tscrollx', 07:00:11 INFO - 'cart']}, 07:00:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:00:11 INFO - 'tsvgr_opacity', 07:00:11 INFO - 'tart', 07:00:11 INFO - 'tscrollx', 07:00:11 INFO - 'cart']}, 07:00:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tp5o']}, 07:00:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'tests': ['tp5o']}, 07:00:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s', 07:00:11 INFO - '--xperf_path', 07:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:11 INFO - 'tests': ['tp5n']}, 07:00:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--xperf_path', 07:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:11 INFO - 'tests': ['tp5n']}}, 07:00:11 INFO - 'talos.zip': {'path': '', 07:00:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:11 INFO - Running post-action listener: _resource_record_post_action 07:00:11 INFO - [mozharness: 2016-10-01 14:00:11.198621Z] Finished populate-webroot step (success) 07:00:11 INFO - [mozharness: 2016-10-01 14:00:11.198749Z] Running create-virtualenv step. 07:00:11 INFO - Running pre-action listener: _resource_record_pre_action 07:00:11 INFO - Running main action method: create_virtualenv 07:00:11 INFO - Creating virtualenv /builds/slave/test/build/venv 07:00:11 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 07:00:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:00:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:11 INFO - Using real prefix '/tools/python27' 07:00:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:00:12 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:14 INFO - Installing pip.................done. 07:00:14 INFO - Return code: 0 07:00:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:00:14 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')]} 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:14 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')]} 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:14 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 0x109af2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9262d8bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109906d30>, '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 0x10976cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098feb20>, '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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 07:00:14 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 07:00:14 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 07:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7C6mgvm5gv/Render', 07:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:14 INFO - 'HOME': '/Users/cltbld', 07:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:14 INFO - 'LOGNAME': 'cltbld', 07:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:14 INFO - 'MOZ_NO_REMOTE': '1', 07:00:14 INFO - 'NO_EM_RESTART': '1', 07:00:14 INFO - 'PAGER': '/bin/cat', 07:00:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:14 INFO - 'PWD': '/builds/slave/test', 07:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:14 INFO - 'SHELL': '/bin/bash', 07:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEFcX5zgx3/Listeners', 07:00:14 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 07:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:14 INFO - 'USER': 'cltbld', 07:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:14 INFO - 'XPC_FLAGS': '0x0', 07:00:14 INFO - 'XPC_SERVICE_NAME': '0', 07:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:15 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 07:00:15 INFO - Cleaning up... 07:00:15 INFO - Return code: 0 07:00:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:00:15 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')]} 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:15 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')]} 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:15 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 0x109af2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9262d8bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109906d30>, '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 0x10976cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098feb20>, '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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 07:00:15 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 07:00:15 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 07:00:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7C6mgvm5gv/Render', 07:00:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:15 INFO - 'HOME': '/Users/cltbld', 07:00:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:15 INFO - 'LOGNAME': 'cltbld', 07:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:15 INFO - 'MOZ_NO_REMOTE': '1', 07:00:15 INFO - 'NO_EM_RESTART': '1', 07:00:15 INFO - 'PAGER': '/bin/cat', 07:00:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:15 INFO - 'PWD': '/builds/slave/test', 07:00:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:15 INFO - 'SHELL': '/bin/bash', 07:00:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEFcX5zgx3/Listeners', 07:00:15 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 07:00:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:15 INFO - 'USER': 'cltbld', 07:00:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:15 INFO - 'XPC_FLAGS': '0x0', 07:00:15 INFO - 'XPC_SERVICE_NAME': '0', 07:00:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:15 INFO - Downloading/unpacking psutil>=3.1.1 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:18 INFO - Installing collected packages: psutil 07:00:18 INFO - Running setup.py install for psutil 07:00:18 INFO - building 'psutil._psutil_osx' extension 07:00:18 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 07:00:19 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 07:00:19 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 07:00:19 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 07:00:19 INFO - building 'psutil._psutil_posix' extension 07:00:19 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 07:00:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:00:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:00:19 INFO - ^ 07:00:19 INFO - 1 warning generated. 07:00:19 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 07:00:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:19 INFO - Successfully installed psutil 07:00:19 INFO - Cleaning up... 07:00:20 INFO - Return code: 0 07:00:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:00:20 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')]} 07:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:20 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')]} 07:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:20 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 0x109af2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9262d8bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109906d30>, '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 0x10976cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098feb20>, '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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 07:00:20 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 07:00:20 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 07:00:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7C6mgvm5gv/Render', 07:00:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:20 INFO - 'HOME': '/Users/cltbld', 07:00:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:20 INFO - 'LOGNAME': 'cltbld', 07:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:20 INFO - 'MOZ_NO_REMOTE': '1', 07:00:20 INFO - 'NO_EM_RESTART': '1', 07:00:20 INFO - 'PAGER': '/bin/cat', 07:00:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:20 INFO - 'PWD': '/builds/slave/test', 07:00:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:20 INFO - 'SHELL': '/bin/bash', 07:00:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEFcX5zgx3/Listeners', 07:00:20 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 07:00:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:20 INFO - 'USER': 'cltbld', 07:00:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:20 INFO - 'XPC_FLAGS': '0x0', 07:00:20 INFO - 'XPC_SERVICE_NAME': '0', 07:00:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:00:20 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 07:00:20 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 07:00:20 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 07:00:20 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 07:00:20 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 07:00:20 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 07:00:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:00:22 INFO - Installing collected packages: mozsystemmonitor 07:00:22 INFO - Running setup.py install for mozsystemmonitor 07:00:22 INFO - Successfully installed mozsystemmonitor 07:00:22 INFO - Cleaning up... 07:00:23 INFO - Return code: 0 07:00:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:23 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 0x109af2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9262d8bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109906d30>, '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 0x10976cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098feb20>, '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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 07:00:23 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 07:00:23 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 07:00:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7C6mgvm5gv/Render', 07:00:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:23 INFO - 'HOME': '/Users/cltbld', 07:00:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:23 INFO - 'LOGNAME': 'cltbld', 07:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:23 INFO - 'MOZ_NO_REMOTE': '1', 07:00:23 INFO - 'NO_EM_RESTART': '1', 07:00:23 INFO - 'PAGER': '/bin/cat', 07:00:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:23 INFO - 'PWD': '/builds/slave/test', 07:00:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:23 INFO - 'SHELL': '/bin/bash', 07:00:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEFcX5zgx3/Listeners', 07:00:23 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 07:00:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:23 INFO - 'USER': 'cltbld', 07:00:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:23 INFO - 'XPC_FLAGS': '0x0', 07:00:23 INFO - 'XPC_SERVICE_NAME': '0', 07:00:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:23 INFO - Downloading/unpacking jsonschema==2.5.1 07:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:26 INFO - warning: no files found matching '*.txt' 07:00:26 INFO - no previously-included directories found matching 'build' 07:00:26 INFO - no previously-included directories found matching 'dist' 07:00:26 INFO - no previously-included directories found matching '.git*' 07:00:26 INFO - Installing collected packages: jsonschema, functools32 07:00:26 INFO - Running setup.py install for functools32 07:00:26 INFO - warning: no files found matching '*.txt' 07:00:26 INFO - no previously-included directories found matching 'build' 07:00:26 INFO - no previously-included directories found matching 'dist' 07:00:26 INFO - no previously-included directories found matching '.git*' 07:00:26 INFO - Successfully installed jsonschema functools32 07:00:26 INFO - Cleaning up... 07:00:26 INFO - Return code: 0 07:00:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:26 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 0x109af2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9262d8bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109906d30>, '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 0x10976cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098feb20>, '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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 07:00:26 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 07:00:26 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 07:00:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7C6mgvm5gv/Render', 07:00:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:26 INFO - 'HOME': '/Users/cltbld', 07:00:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:26 INFO - 'LOGNAME': 'cltbld', 07:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:26 INFO - 'MOZ_NO_REMOTE': '1', 07:00:26 INFO - 'NO_EM_RESTART': '1', 07:00:26 INFO - 'PAGER': '/bin/cat', 07:00:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:26 INFO - 'PWD': '/builds/slave/test', 07:00:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:26 INFO - 'SHELL': '/bin/bash', 07:00:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEFcX5zgx3/Listeners', 07:00:26 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 07:00:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:26 INFO - 'USER': 'cltbld', 07:00:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:26 INFO - 'XPC_FLAGS': '0x0', 07:00:26 INFO - 'XPC_SERVICE_NAME': '0', 07:00:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:00:26 INFO - Cleaning up... 07:00:26 INFO - Return code: 0 07:00:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:26 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 0x109af2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9262d8bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109906d30>, '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 0x10976cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098feb20>, '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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 07:00:26 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 07:00:26 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 07:00:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7C6mgvm5gv/Render', 07:00:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:26 INFO - 'HOME': '/Users/cltbld', 07:00:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:26 INFO - 'LOGNAME': 'cltbld', 07:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:26 INFO - 'MOZ_NO_REMOTE': '1', 07:00:26 INFO - 'NO_EM_RESTART': '1', 07:00:26 INFO - 'PAGER': '/bin/cat', 07:00:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:26 INFO - 'PWD': '/builds/slave/test', 07:00:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:26 INFO - 'SHELL': '/bin/bash', 07:00:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEFcX5zgx3/Listeners', 07:00:26 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 07:00:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:26 INFO - 'USER': 'cltbld', 07:00:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:26 INFO - 'XPC_FLAGS': '0x0', 07:00:26 INFO - 'XPC_SERVICE_NAME': '0', 07:00:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:27 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 07:00:27 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 07:00:27 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 07:00:27 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 07:00:27 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 07:00:27 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 07:00:29 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:00:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00:30 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 07:00:30 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 07:00:30 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 07:00:30 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 07:00:30 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 07:00:30 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 07:00:30 INFO - Downloading docopt-0.6.1.tar.gz 07:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:30 INFO - Running setup.py install for blobuploader 07:00:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:00:30 INFO - Running setup.py install for requests 07:00:31 INFO - Running setup.py install for docopt 07:00:31 INFO - Successfully installed blobuploader requests docopt 07:00:31 INFO - Cleaning up... 07:00:31 INFO - Return code: 0 07:00:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:31 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')]} 07:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:31 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')]} 07:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:31 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 0x109af2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9262d8bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109906d30>, '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 0x10976cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098feb20>, '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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 07:00:31 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 07:00:31 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 07:00:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7C6mgvm5gv/Render', 07:00:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:31 INFO - 'HOME': '/Users/cltbld', 07:00:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:31 INFO - 'LOGNAME': 'cltbld', 07:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:31 INFO - 'MOZ_NO_REMOTE': '1', 07:00:31 INFO - 'NO_EM_RESTART': '1', 07:00:31 INFO - 'PAGER': '/bin/cat', 07:00:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:31 INFO - 'PWD': '/builds/slave/test', 07:00:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:31 INFO - 'SHELL': '/bin/bash', 07:00:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEFcX5zgx3/Listeners', 07:00:31 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 07:00:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:31 INFO - 'USER': 'cltbld', 07:00:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:31 INFO - 'XPC_FLAGS': '0x0', 07:00:31 INFO - 'XPC_SERVICE_NAME': '0', 07:00:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:31 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-lyvtDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-YpncFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-3wrHKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-UdpNiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-xjphGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-Z5mXTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-5OeCgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-Ny7CXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-Eyf4hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:32 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-t3aJoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-9EuKAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-SppmjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-4OJ7h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-VPueXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-rHMM9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-duJTW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:33 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-5aDA3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:33 INFO - Running setup.py install for manifestparser 07:00:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:00:33 INFO - Running setup.py install for mozcrash 07:00:34 INFO - Running setup.py install for mozdebug 07:00:34 INFO - Running setup.py install for mozdevice 07:00:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:00:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:00:34 INFO - Running setup.py install for mozfile 07:00:34 INFO - Running setup.py install for mozhttpd 07:00:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:00:34 INFO - Running setup.py install for mozinfo 07:00:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:00:34 INFO - Running setup.py install for mozInstall 07:00:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:00:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:00:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:00:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:00:34 INFO - Running setup.py install for mozleak 07:00:35 INFO - Running setup.py install for mozlog 07:00:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Running setup.py install for moznetwork 07:00:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Running setup.py install for mozprocess 07:00:35 INFO - Running setup.py install for mozprofile 07:00:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Running setup.py install for mozrunner 07:00:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Running setup.py install for mozscreenshot 07:00:35 INFO - Running setup.py install for moztest 07:00:36 INFO - Running setup.py install for mozversion 07:00:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:00:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:36 INFO - Cleaning up... 07:00:36 INFO - Return code: 0 07:00:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:36 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')]} 07:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:36 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')]} 07:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:36 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 0x109af2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9262d8bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109906d30>, '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 0x10976cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098feb20>, '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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 07:00:36 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 07:00:36 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 07:00:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7C6mgvm5gv/Render', 07:00:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:36 INFO - 'HOME': '/Users/cltbld', 07:00:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:36 INFO - 'LOGNAME': 'cltbld', 07:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:36 INFO - 'MOZ_NO_REMOTE': '1', 07:00:36 INFO - 'NO_EM_RESTART': '1', 07:00:36 INFO - 'PAGER': '/bin/cat', 07:00:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:36 INFO - 'PWD': '/builds/slave/test', 07:00:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:36 INFO - 'SHELL': '/bin/bash', 07:00:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEFcX5zgx3/Listeners', 07:00:36 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 07:00:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:36 INFO - 'USER': 'cltbld', 07:00:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:36 INFO - 'XPC_FLAGS': '0x0', 07:00:36 INFO - 'XPC_SERVICE_NAME': '0', 07:00:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:36 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-fge1Km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:36 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)) 07:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:36 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-ycuPa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:36 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)) 07:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:36 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-mcVO27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:36 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)) 07:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:36 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-cLcFtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-uIzNEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-eqSrBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-arzWtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-g7l38M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-4Fi98o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-Ysdc1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-bcxAWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-Oh1BkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-kU2c1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:37 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-6PtqW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-regBtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-NMCUqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:38 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-X3JtgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:38 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)) 07:00:38 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)) 07:00:38 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)) 07:00:38 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)) 07:00:38 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)) 07:00:38 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)) 07:00:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:38 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 07:00:38 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 07:00:38 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 07:00:38 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 07:00:38 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 07:00:38 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 07:00:40 INFO - Downloading blessings-1.6.tar.gz 07:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:40 INFO - Installing collected packages: blessings 07:00:40 INFO - Running setup.py install for blessings 07:00:41 INFO - Successfully installed blessings 07:00:41 INFO - Cleaning up... 07:00:41 INFO - Return code: 0 07:00:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:41 INFO - Reading from file tmpfile_stdout 07:00:41 INFO - Current package versions: 07:00:41 INFO - blessings == 1.6 07:00:41 INFO - blobuploader == 1.2.4 07:00:41 INFO - docopt == 0.6.1 07:00:41 INFO - functools32 == 3.2.3-2 07:00:41 INFO - jsonschema == 2.5.1 07:00:41 INFO - manifestparser == 1.1 07:00:41 INFO - mozInstall == 1.12 07:00:41 INFO - mozcrash == 0.17 07:00:41 INFO - mozdebug == 0.1 07:00:41 INFO - mozdevice == 0.48 07:00:41 INFO - mozfile == 1.2 07:00:41 INFO - mozhttpd == 0.7 07:00:41 INFO - mozinfo == 0.9 07:00:41 INFO - mozleak == 0.1 07:00:41 INFO - mozlog == 3.4 07:00:41 INFO - moznetwork == 0.27 07:00:41 INFO - mozprocess == 0.23 07:00:41 INFO - mozprofile == 0.28 07:00:41 INFO - mozrunner == 6.12 07:00:41 INFO - mozscreenshot == 0.1 07:00:41 INFO - mozsystemmonitor == 0.3 07:00:41 INFO - moztest == 0.7 07:00:41 INFO - mozversion == 1.4 07:00:41 INFO - psutil == 3.1.1 07:00:41 INFO - requests == 1.2.3 07:00:41 INFO - wsgiref == 0.1.2 07:00:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:41 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 0x109af2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9262d8bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109906d30>, '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 0x10976cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098feb20>, '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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 07:00:41 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 07:00:41 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 07:00:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7C6mgvm5gv/Render', 07:00:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:41 INFO - 'HOME': '/Users/cltbld', 07:00:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:41 INFO - 'LOGNAME': 'cltbld', 07:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:41 INFO - 'MOZ_NO_REMOTE': '1', 07:00:41 INFO - 'NO_EM_RESTART': '1', 07:00:41 INFO - 'PAGER': '/bin/cat', 07:00:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:41 INFO - 'PWD': '/builds/slave/test', 07:00:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:41 INFO - 'SHELL': '/bin/bash', 07:00:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEFcX5zgx3/Listeners', 07:00:41 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 07:00:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:41 INFO - 'USER': 'cltbld', 07:00:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:41 INFO - 'XPC_FLAGS': '0x0', 07:00:41 INFO - 'XPC_SERVICE_NAME': '0', 07:00:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:41 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)) 07:00:41 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)) 07:00:41 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)) 07:00:41 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)) 07:00:41 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)) 07:00:41 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)) 07:00:41 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)) 07:00:41 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)) 07:00:41 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)) 07:00:41 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)) 07:00:41 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)) 07:00:41 INFO - Cleaning up... 07:00:41 INFO - Return code: 0 07:00:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:41 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 0x109af2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9262d8bd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109906d30>, '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 0x10976cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098feb20>, '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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 07:00:41 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 07:00:41 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 07:00:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7C6mgvm5gv/Render', 07:00:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:41 INFO - 'HOME': '/Users/cltbld', 07:00:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:41 INFO - 'LOGNAME': 'cltbld', 07:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:41 INFO - 'MOZ_NO_REMOTE': '1', 07:00:41 INFO - 'NO_EM_RESTART': '1', 07:00:41 INFO - 'PAGER': '/bin/cat', 07:00:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:41 INFO - 'PWD': '/builds/slave/test', 07:00:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:41 INFO - 'SHELL': '/bin/bash', 07:00:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEFcX5zgx3/Listeners', 07:00:41 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 07:00:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:41 INFO - 'USER': 'cltbld', 07:00:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:41 INFO - 'XPC_FLAGS': '0x0', 07:00:41 INFO - 'XPC_SERVICE_NAME': '0', 07:00:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:00:42 INFO - Cleaning up... 07:00:42 INFO - Return code: 0 07:00:42 INFO - Running post-action listener: _resource_record_post_action 07:00:42 INFO - Running post-action listener: _start_resource_monitoring 07:00:42 INFO - Starting resource monitoring. 07:00:42 INFO - [mozharness: 2016-10-01 14:00:42.103010Z] Finished create-virtualenv step (success) 07:00:42 INFO - [mozharness: 2016-10-01 14:00:42.103965Z] Running install step. 07:00:42 INFO - Running pre-action listener: _resource_record_pre_action 07:00:42 INFO - Running main action method: install 07:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:42 INFO - Reading from file tmpfile_stdout 07:00:42 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:00:42 INFO - Reading from file tmpfile_stdout 07:00:42 INFO - Output received: 07:00:42 INFO - Usage: mozinstall [options] installer 07:00:42 INFO - Options: 07:00:42 INFO - -h, --help show this help message and exit 07:00:42 INFO - -d DEST, --destination=DEST 07:00:42 INFO - Directory to install application into. [default: 07:00:42 INFO - "/builds/slave/test"] 07:00:42 INFO - --app=APP Application being installed. [default: firefox] 07:00:42 INFO - mkdir: /builds/slave/test/build/application 07:00:42 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'] 07:00:42 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 07:01:14 INFO - Reading from file tmpfile_stdout 07:01:14 INFO - Output received: 07:01:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:01:14 INFO - Running post-action listener: _resource_record_post_action 07:01:14 INFO - [mozharness: 2016-10-01 14:01:14.778304Z] Finished install step (success) 07:01:14 INFO - [mozharness: 2016-10-01 14:01:14.778410Z] Running run-tests step. 07:01:14 INFO - Running pre-action listener: _resource_record_pre_action 07:01:14 INFO - Running main action method: run_tests 07:01:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:01:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:01:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:01:14 INFO - 2016-10-01 07:01:14.792 screenresolution[1650:8540] starting screenresolution argv=screenresolution get 07:01:14 INFO - 2016-10-01 07:01:14.795 screenresolution[1650:8540] Display 0: 1600x1200x32@60 07:01:14 INFO - 2016-10-01 07:01:14.801 screenresolution[1651:8543] starting screenresolution argv=screenresolution list 07:01:14 INFO - Available Modes on Display 0 07:01:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:01:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:01:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:01:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:01:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:01:15 INFO - Intel Iris: 07:01:15 INFO - Chipset Model: Intel Iris 07:01:15 INFO - Type: GPU 07:01:15 INFO - Bus: Built-In 07:01:15 INFO - VRAM (Dynamic, Max): 1536 MB 07:01:15 INFO - Vendor: Intel (0x8086) 07:01:15 INFO - Device ID: 0x0a2e 07:01:15 INFO - Revision ID: 0x0009 07:01:15 INFO - Displays: 07:01:15 INFO - Display: 07:01:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:01:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:01:15 INFO - Display Serial Number: 1600x1200 60 07:01:15 INFO - Main Display: Yes 07:01:15 INFO - Mirror: Off 07:01:15 INFO - Online: Yes 07:01:15 INFO - Rotation: Supported 07:01:15 INFO - Return code: 0 07:01:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:01:15 INFO - Python 2.7.3 07:01:15 INFO - Return code: 0 07:01:15 INFO - grabbing minidump binary from tooltool 07:01:15 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')]} 07:01:15 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 0x109906d30>, '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 0x10976cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098feb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:01:15 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 07:01:15 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 07:01:15 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 07:01:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:01:15 INFO - Return code: 0 07:01:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:01:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:01:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:01:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:01:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:01:15 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0267', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:01:15 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0267 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:01:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7C6mgvm5gv/Render', 07:01:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:01:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:01:15 INFO - 'HOME': '/Users/cltbld', 07:01:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:01:15 INFO - 'LOGNAME': 'cltbld', 07:01:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:01:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:15 INFO - 'MOZ_NO_REMOTE': '1', 07:01:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:01:15 INFO - 'NO_EM_RESTART': '1', 07:01:15 INFO - 'PAGER': '/bin/cat', 07:01:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:15 INFO - 'PWD': '/builds/slave/test', 07:01:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:01:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:01:15 INFO - 'SHELL': '/bin/bash', 07:01:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEFcX5zgx3/Listeners', 07:01:15 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 07:01:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:01:15 INFO - 'USER': 'cltbld', 07:01:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:01:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:15 INFO - 'XPC_FLAGS': '0x0', 07:01:15 INFO - 'XPC_SERVICE_NAME': '0', 07:01:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:01:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0267', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:01:15 INFO - mozversion application_buildid: 20161001055157 07:01:15 INFO - mozversion application_changeset: cd209acf4fb537c08788b69bf1c93370becee0d2 07:01:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:01:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:01:15 INFO - mozversion application_name: Firefox 07:01:15 INFO - mozversion application_remotingname: firefox-dev 07:01:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:01:15 INFO - mozversion application_vendor: Mozilla 07:01:15 INFO - mozversion application_version: 51.0a2 07:01:15 INFO - mozversion platform_buildid: 20161001055157 07:01:15 INFO - mozversion platform_changeset: cd209acf4fb537c08788b69bf1c93370becee0d2 07:01:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:01:15 INFO - mozversion platform_version: 51.0a2 07:01:15 INFO - using testdate: 1475330475 07:01:15 INFO - actual date: 1475330475 07:01:15 INFO - starting webserver on 'localhost:49274' 07:01:15 INFO - SUITE-START | Running 2 tests 07:01:15 INFO - TEST-START | dromaeo_css 07:01:15 INFO - operating with platform_type : mac_ 07:01:15 INFO - Initialising browser for dromaeo_css test... 07:01:15 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpEScxsR/profile http://localhost:49274/getInfo.html) 07:01:18 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 07:01:18 INFO - PROCESS | 1661 | colorDepth:24 07:01:18 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 07:01:18 INFO - PROCESS | 1661 | __metrics 07:01:18 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 07:01:18 INFO - TEST-INFO | 1661: exit 0 07:01:18 INFO - Browser initialized. 07:01:18 INFO - Running cycle 1/1 for dromaeo_css test... 07:01:18 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpEScxsR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:31 INFO - PROCESS | 1666 | RSS: Main: 224968704 07:01:31 INFO - PROCESS | 1666 | 07:02:20 INFO - PROCESS | 1666 | 1475330540689 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] 07:04:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 07:04:34 INFO - PROCESS | 1666 | RSS: Main: 237166592 07:04:34 INFO - PROCESS | 1666 | 07:07:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 07:07:36 INFO - PROCESS | 1666 | RSS: Main: 249778176 07:07:36 INFO - PROCESS | 1666 | 07:10:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 07:10:39 INFO - PROCESS | 1666 | RSS: Main: 252059648 07:10:39 INFO - PROCESS | 1666 | 07:13:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 07:13:42 INFO - PROCESS | 1666 | RSS: Main: 252301312 07:13:42 INFO - PROCESS | 1666 | 07:16:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 07:16:45 INFO - PROCESS | 1666 | RSS: Main: 256516096 07:16:45 INFO - PROCESS | 1666 | 07:19:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 07:19:48 INFO - PROCESS | 1666 | RSS: Main: 258514944 07:19:48 INFO - PROCESS | 1666 | 07:19:48 INFO - PROCESS | 1666 | __start_tp_report 07:19:48 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 07:19:48 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 07:19:48 INFO - PROCESS | 1666 | |i|pagename|runs| 07:19:48 INFO - PROCESS | 1666 | |0;dojo.html;2882.293838009688;2903.7241462061097;3216.469282568376;3472.9652703472957;3494.912627184321;5790.160426738125;5846.56150788691;5878.794242201524;5895.439933206349;5896;4844.418669759634;5819.67991760453;5853.8829223415505;5890.823275301748;5932.525397968163;5329.333833270851;5368.758405871745;5390;5430.755615997289;5430.91853622196;5399.487048730364;5412.4587541245955;5436.565074794027;5443.755031023614;5465.371482279549;5283.177303830192;5308.283381743454;5418.783248670048;5431.266778984846;5432.185172224158;5319.281896943921;5337.973310133424;5354.4645535446725;5358.758855851496;5368.006918720011;5230.973845130788;5252.763625636855;5315.760790764425;5387.057264978613;5424.321959755031;4585.7248565085865;4885.6335774817035;5932.199153114318;5955.731992060368;5957.672328021957;4807.423109226916;5533.335999680065;5682.920245153449;6133.059244993061;6196.1635179251125;5079.619028572835;5114.900296436247;5595.272614560122;6404.007378856285;6406.93593064068;4538.614217791492;5747.281589801317;5913;6056.515478761688;6068.969655151696;6406.5515413920575;6412.294647588761;6462.967685161544;6495.512836537184;6510.934890651033;5545.473180047889;5864.8533786654825;6242.812715618538;6251.156093927352;6257.9687101564205;6184.196054512974;6195.566310358322;6233.470155036782;6343.809685709436;6349.015902535114;6177.536684748572;6232.626042437469;6246.406591373812;6289.056641503811;6325.209348831396;6258.967270400333;6272.466840318624;6280.089387038854;6284.780032698834;6298.622082675054;4893.486183950705;5086.694798312114;5091.1854103343285;5091.3126727892;5092.567131793839;4430.113977204572;4450.532694067077;4476.955230447654;4527.388802511685;4572.74849883253;6017.909731354033;6022.5483088768515;6045.879082418327;6064.211652485149;6091.725872335755;6164.969175154096;6338.461230795342;6349.396807303298;6350.904736428957;6361.173047503888;5838.9124163137585;6032.336442991267;6065.666388348595;6071.574989750675;6106.969465152646;5538.501534861801;5561.249231353796;5563.5271001964475;5574.721263936787;5607.579431542651;6521.184851893513;6597.835054123493;6609.702563384563;6616.669166541654;6620.602763834186;6170.197874276315;6223.097650840693;6227.346128656426;6236.095766113797;6292.937070629235;6576.375244351779;6584.8024559261385;6589.571677840925;6614;6615.503837212132;6248.687565621792;6300.9684951574945;6315.021171718391;6323.588966717149;6327.525435592257;6169.2288463942;6179.134921111138;6203.914314994948;6261.279952805486;6279.560430769802;5018.3977922648055;6245.281792593728;6256.874862502634;6263.937360626518;6288.434040936338;6222.688865556614;6247.68761561911;6253.906191407224;6258.655773932477;6268.498520118471;5743.59794814359;6072.878542429038;6094.939050609437;6115.694215289307;6117.0824376342125;6150.200473938538;6205.596636218631;6229.221347331583;6253;6253.09330147117;6109.725062372115;6155.692215389302;6164.6917654118015;6179.258488981351;6188.659623720739 07:19:48 INFO - PROCESS | 1666 | |1;ext.html;454.62039197270275;495.3065708008787;513.8694871283178;543.0849019402308;552.593843525009;31597.368052638933;34894.825525872366;39610.60389396105;39728.801355993215;39779.602203977985;40680.59319406805;41316;41408.378874316906;41421.792891035504;41448.96377590562;9589.520523973808;9803.41179529227;9808.50957452128;9828.508574571242;9838.458884761336;9736.610535578604;9835.01649835018;9849.753756156082;9880.703578892644;9928.156106730936;9786;9849.965753595841;9857.162141218005;9899.851502227473;9936.850947235796;9796.412215267072;9821.165200957927;9821.607135714563;9844.950775246078;9851.753706157404;9732.172765314957;9846.261530385178;9847.60609575616;9849.704508864674;9854;39286;39577.60422395768;39590.406143907865;39604.603953960665;39683.40474892879;3431;3881.0879443330796;3896.5129358830145;3934.449177115206;3989.880303590897;29412.558811617844;30003.549946750816;30571;31438.74245030219;31814.04557863268;3007.624046994126;3061.5866857974333;3168.0495851244536;3182.315802102536;3184.8885289015006;419815;436874;506050;508580;511982.4400877972;61715.69142154261;62141.68929155325;62418;62480.06279905805;62696.373036269055;34304;35060.298794024486;64496.677516612115;64937.67531162409;65183.67408162929;16361.181940903145;16754.74867876983;16946.98318100918;16954;16966.830331696772;12994.090413671142;13039.087263891626;13039.869601304055;13046.347682615831;13050.934745326402;19020.809791901906;19076.61846763057;19091.2363505461;19093.90453047726;19142.330018449287;7581.6209189541405;7682.692692292246;8105.918940810634;8226.547539885363;8312.04411492686;800.5756948817136;841.8610929196614;893.0444424465759;980.7155924781733;1026.0867827633263;29880.78126321135;30242.24394390114;30443.847780761396;30741;30852.845735771178;1034.9327293725885;1037.3827572594294;1060.3955745225148;1092.093562343253;1171.1275100050516;15431.228438578026;15888.841111588967;15944.2825072872;16160.111193884213;16465.83534164667;683442;697284;697288;698101;700990;47973;48210.758946205046;51379.74310128426;56326.15510767342;57056.42943570594;1245.1470742541387;1269.7587458382877;1362.3664995777012;1373.2858913364994;1376.7521846067605;23771.286861394186;27196.456070878077;29322.706772931997;30043.699563004964;30673.38653226878;38037;49903.75048124736;50010;50013.49932503433;50072.49927500824;607273;615801;617686;619752;620141;25865.482690346464;26273.423594584387;26551.601725974513;26602.733972660026;26668.466630667666;47020.29469557891;47167.76416117897;47733.419993499934;47833.28250076182;48548.78628034327;38837.80581097076;39033.609663903;40322.99664702507;40611.796941015105;40637.59362406338;39148.0212994666;39292.01769955774;40375.1924961505;40386;40473.39289910712;37710.24579508339;37812.05469863275;37988;38090.61909380871;38843.41734874035;30561;32330.515042273913;32954;34201.343887703704;34942.475862862586;25969;25989.87005065038;26044.869775651;26068.73931260663;26476.602850957635 07:19:48 INFO - PROCESS | 1666 | |2;jquery.html;373.89717827597406;377.31153089922583;384.1299456730505;386.0464652308796;401.5241938303111;18985.14566844492;20642.89678551607;20649.483762905937;20737.688934665992;20899;20041.198352065938;20244.493887652818;20574.588508229826;20700.27549035784;20742.377728668125;5968.522518198544;5984.88030239395;6108.725107370156;6113.6943152842405;6172.1667574877265;4241.34259189826;4463.687541872054;6067.848303792419;6153.9384606154035;6157.384261573851;6509.925862232726;6802.38778509934;6862.451003919675;6891.552049116816;6917.204521480044;6619.4704423646235;6820.045193672865;6859.759908403182;6864.2106157791995;6884.242733299333;5891.116332550109;5981.52147828177;6018.6990650467305;6027.487663548603;6036.758529658809;25786.48427031449;26137.477250455075;26164.34589135287;26261.73738262612;26343.94624215029;2352.270796053229;2356.2813341930705;2448.43685952232;2478.491909158618;2613.751693589106;14966.925165374212;14999.1750453725;15070.321835517429;15597.986130901456;15961.521154365271;1824.6350729854082;1897.3928342930267;1909.5321646196771;1911.7419148415065;1913.3016448996016;112805.43597282043;114928;115867;115889;116367;9093.22707569864;10904.236703430684;11326.490307936163;11358.432078396047;11459.45297384859;10726.678199654023;14036.859631403555;14084.15495070299;14110.576682699535;14149.363278652485;7384.409247260206;8770.473771573726;8884.555772211364;8913.019567847532;8928.73213803587;7330.340269375782;7424.443166762514;9003.909960900308;9159.725208243763;9171.724848254564;5644.943550564524;6772.11962444879;6840.281770414134;6879.3120687930805;6880.483963702743;1447.254663848119;1721.5954250751063;1837.86216033798;1868.374094678298;1898.5633304340079;842.5787106446777;880.1682410122501;900.9009009009004;941.1952780372819;947.3652652722692;21701.457463563536;21975.670364944537;22060.779392206194;22171.445713857283;22268.7752173632;935.2050756856618;955.8422860227985;964.3490643815537;979.6424305128577;991.6231831903831;9715.319927605142;11243.381614011145;11655;11812;11843.940780296043;571885;579549;584994;619378;624615;68996;72210;97818.53272200923;123606.76393236133;136388.31805841107;930.5951910918772;931.9440833550009;971.1308379000895;971.5433746139303;1000.9949950250348;14780.852191477947;15476.690466190837;17017.57456063559;18621.348252811087;19102.522436939187;45593;56613.58466038382;58591.70704146452;58741.70629146827;59863.70068149632;87564.56217718871;87661.56169219113;88068;89003;89235.55382223047;6770.830729231809;6977.441804655514;8220.219079187467;8250.711225107092;8376.162383761575;11320.943395282971;12962.740745184854;13068.085234033526;13159.93420032932;13396.732065358834;7547.660355283915;11029.61396351124;11124.944375278072;11212.383318917538;11529.020033296929;9933.701988940344;10940.45297735126;11172.608958686407;11348.602798901999;11365.48855301497;11314.943425282821;11354.886451135713;11383.487743051417;11443.313401195623;11565.016973557342;7237.710491580277;7984;8136.75589732309;8313.916860831314;8424.873626895478;8313.6674533018;10675.412852293199;10975.341479511255;11221.046211071824;11327.037201837606 07:19:48 INFO - PROCESS | 1666 | |3;mootools.html;1349.6895713985787;1514.2050423527646;1672.4731709511502;1767.3372485318005;1816.0465755478365;8185.386096042791;8448.873266901;8797.296216302688;9272.443653380802;9296.90703092969;7721.498102623325;8686.348523860705;9031.638734450615;9089.863652045224;9100.681476148337;2398.73613902471;2430.1130087518104;2431.7932975697086;2438.036975394718;2443.059422122478;2414.915477958272;2434.805215582749;2461.9261422157365;2466.124525793344;2466.2847774145475;2420.334408037786;2428.8178386620984;2431.8540887546715;2449.9755002449924;2460.2496238647204;2419.637054441839;2426.6360045993065;2428.077330614373;2446.0338166424162;2450.1424501424535;2400.1599440195964;2402.6636270922086;2406.2420337593776;2411.4333131714034;2415.0460568075687;7584.317411432942;8986.14631609996;9088.68189613367;9098.86351704725;9105.180533751927;4677.345171675934;4912.77892494835;5345.705986170759;5518.448155184489;5524.254225679522;3573.4282514797505;3705.7776533407814;3721.813909304524;3763.510743603314;3784.4701741756176;1081.2701426537055;1105.618561596248;1112.3770688414434;1128.0242590159535;1130.9943450282697;12126.696832579168;12303.32331721746;12335.691607709789;12354.25874447536;12374;4423.18171138334;4511.548573011404;4823.2282834746275;4969.155243608595;5012.423571289275;8811.559422028873;10230.744231394274;10280.640177593898;10358.326708763907;10516.526756295985;5432.674039557639;5477.384171669367;5492.066348720727;5500.312460942382;5500.532454741392;4462.866114016585;4603.792829322621;4862.489438608965;4978.377702787152;5040.445550989388;3561.0207193022125;4053.70281509914;4089.3048181809163;4114.423980642652;4143.212789569972;1310.7902735562263;1319.162331919219;1328.8338957630297;1331.7403106394354;1336.5054929675887;639.5555089213045;775.337086790797;908.6955869783696;914.5061666700041;927.3879239701764;5903.380145084704;5987.191729116601;6034.698265086816;6086.543509236825;6200;799.8160423102719;942.8114377124602;971.9902800972042;990.9355891867006;997.4912794474725;3948.763074215499;4061.1674606705556;4123.072308730511;4156.376543518496;4169.374593810952;10750;11102.389368584805;11227.326360418401;11242.775144497227;11253.987141157335;10875.401852898009;10904.400257985728;11022.063124634336;11127.054200392895;11150;8412.621432035574;8532.701355452653;8545.786355341166;8552.572371381406;8580.485170889891;4970.577500912318;5431.619786615057;5978.581499295007;6035.064564992434;6086.421789929949;10206.489675516046;10222.335548189343;10430.478476076318;10454.32046916948;10541.57833686644;9963.900360996297;10348.172146228133;10397.116245118947;10563.841542377024;10572.629957951434;7147.213806481387;7382.52013619113;7533.510321829063;7769.378449723896;7921.564313962787;8418.326533877398;8722.99685536146;8729.170728780755;8763.430377025474;8765.34259930495;7619.847603048019;7720.073591169095;7750.844983100419;7859.52842829432;7868.763937081897;7526.5860377679755;7560.8487830244185;7593.734219302298;7611;7635.541867487968;7079.610621415872;7138.892916606152;7211.891821622575;7216.819579510554;7233.31283528064;4999.125153098266;5035.748212589429;5068.21442676371;5178.974105129601;5295.25866378715;4369.7159684621665;5052.252682238054;5101.627743099477;5201.713905735221;5309.920351194658 07:19:48 INFO - PROCESS | 1666 | |4;prototype.html;293.19956518703935;306.90946170879573;313.5344014139003;316.52205170193014;319.4170638584584;4186.811593478294;4515.232410490216;4831.396075490564;5248.317718696569;5532.668039917603;4682.953170468294;5457.017736807373;5495.725213739317;5523.337199536061;5548.44515548445;4223.66210703143;4251.2135254977775;4252.746044596369;4262.78686065697;4265.530791612936;3240.7245384142375;4212.894677633069;4267.317229243322;4271.807768650403;4278.080212754257;4193.790310484479;4202.852900148496;4211.873643790691;4212.789360531977;4222.662187025031;4043.696722745806;4199.496060472763;4213.936790948138;4222.408862759216;4240.893977650552;2983.015604850394;3011.8494075296367;3434.4161492546327;3636.2909432566653;3652.4338727497015;4058.5738497457637;4966.329545511346;5400.756965936543;5416.1063424534905;5446.754896029688;4485.484169320504;4593.208648627038;4804.357603318161;4839.516048395168;4852.805887764485;5019.799208031674;5461.808836690737;5822.7088645567555;5903.35063143054;5989.64062156272;3660.5058317127114;3790.0102446215683;3891.8637847675477;3987.362022076483;3987.760734355948;5635.6055076144685;6170.259568851721;6208.5033197344555;6210.962874131806;6279.780207692709;3565.2512972276113;4020.537638171648;4033.69747268956;4064.898377540526;4066.3493840985893;3915.031671551329;4016.9598304016586;4092.4475195848777;4100.610442008005;4102.261592913304;4769.499202583748;4769.758213639584;4813.125434025573;4820.096062055469;4831.371921650233;4940.258961155783;5581.6930068846605;5912.76348946046;5916.73374698131;5951.958407278709;1165.7085728567858;1273.8216649669055;1306.1901620995043;1323.8676132386877;1397.1407584335764;783.3302526340011;789.3487872505207;843.2958479669422;855.5593869157389;861.6510313323114;4529.547045295444;4690.460597031385;4784.210605250095;4823.5658790709;4843.975780121077;5118.769655365518;5127.179851152787;5127.79488820443;5171.301874247004;5212.921806172911;4359.411479450297;4585.426821647294;4596.37948876904;4607.308903664477;4635.890669745258;2654.336415896026;2674.5185866544207;2711.667965549626;2723.850188239666;2732.221316924667;5138.460461651547;5210.925553923204;5223.817166399158;5345.893082138336;5370.630489225223;4793.5307625306505;4890.462049174588;5029;5267.868303292448;5279.340082489689;4192.979035104805;4474.6867719259335;4686.851721328228;4813.831515896997;4842.789302674331;4084.9795751021056;4431.828404082041;4814.975925120352;4959.330490383752;5135.408023512723;4415.977920110379;4672.322513235494;5062.443131255633;5096.668716533413;5126.564242039469;5892.587518873637;6412.775552855815;6413.8834184718;6435;6489.480841532761;4027.7381970171846;4061.0659548304648;4070.75575465473;4071.959280407158;4084.4690190275073;5784.971075144597;5810.767569297181;6025.427584379477;6110.686202466491;6170;4753.716496545982;4912.85261442143;5477;5807.573531616366;6021.608595441282;5960.956832554199;6010.819675409744;6013.30846952606;6034.879302414015;6094.055421409688;5006.123928312458;5115.820946266863;5778.219940308173;5809.419058094157;5851.824445266649;5938.990371636745;5963.52291816645;5980.308861012475;5993.572603095753;6010.819675409744;5525.861853453695;5649.180868774087;5782.942170578409;5860.443257890493;5882.764689412375 07:19:48 INFO - PROCESS | 1666 | |5;yui.html;690.3027941778802;734.2694019450647;750.6884642873208;764.9502782319149;806.5201205282857;14969.775453368195;15519.92240038801;15542.378304867792;15549.067055976635;15656.3737450502;13978.580642580739;14102.012859099841;14112.29438528072;14146.080504767184;14168.929155354235;808.5633757770811;840.260570697785;875.0811647769848;878.5343767803042;878.5431575580694;869.5043825019741;870.5951732444412;871.559862269553;873.3449912565576;875.829213303406;905.4431524612381;909.2180724576858;913.8218047480744;914.1498406481969;915.2906497464452;868.9217970382696;878.793483531376;893.6112790935931;904.5070436611996;909.1045320359441;644.5101722690742;664.5945972956492;675.5743881354715;676.9289224631441;678.8099332186996;15206.695866082617;15330.846691533165;15468.14925179126;15470;15513.922430387776;14142.787858182135;14153.716925661533;14322.856771432256;14347.354369053313;14358.210298433582;11741.706457338549;11897.643070707893;11925.463354149084;12068.396580170956;12493;3555.3600351936643;3573.803440810754;3738.719596030309;3800.619938006205;3824.2542704172697;117771;121177;122337;122532.38733806364;123996;10701.946490267499;10798.136149108053;11033.6138235163;11033.779324413466;11181.552737890555;22326.665100023514;22330.55338893213;22439.663405048937;22499.212527561456;22664;7965.084015338311;7970;7988.400869934778;8094.595270236465;8192.098869124391;4141.130362623822;4359.12817436514;4485.0581377911;4532.864014079517;4552.954470455319;3635.163912300186;3671.0822294426393;3753.7184711146774;3760.435934609776;3761.153740408386;599.4005994005994;613.7357044488368;647.4626060369882;650.629141389413;676.8307923019245;534.569671414515;569.2002736155708;573.7183311458451;580.8896309701144;630.4263120560269;8065.354771618257;9075.500847453453;9587.328886977984;9637.9036209637;9703.24778537581;546.336201515161;607.3683369295883;613.6502193749609;624.6096189881324;634.22307673101;4594.173048851172;4704.317873908264;4761.95238047622;4763.214069678534;4781;105279.4736026315;120255;162761.37238627463;166210.16894915447;169415;114028.42985785018;118727;124684;127595.44809103766;147197;105437;111409.88590113995;111986.44006779914;112586.87413125765;114307;8773.561321934005;9739.707808765748;10169.03394177552;10198.898011019795;10298;49191.23930022285;58604.4139558616;60209;63740;64321;63996.36003639904;66199.33800661932;91284;94572.52713736387;96991;11078.501467433824;11474.885251147381;11507.252028618113;11511.597094101666;11545.36500492481;12158.574449894211;12316.445759941003;12475.126741128033;12540.310282934526;12705.428255728699;11784.882151178379;12017.939910300393;12052.457639406073;12055.276683399024;12447.813282800584;11513.194076414571;11715.941420292844;11948.940255298668;12108.878911211128;12525.248485090924;9491.952540237531;11937.403129843648;12070;12080.577179798665;12094.274343539415;9751.951240243754;10122.848157277795;10313.27807053499;10346.430946297725;10410.375377477376;10149.797004060025;10237.795244095225;10329.328593641389;10339.948300258451;10349.896501034893 07:19:48 INFO - PROCESS | 1666 | __end_tp_report 07:19:48 INFO - PROCESS | 1666 | __start_cc_report 07:19:48 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,366 07:19:48 INFO - PROCESS | 1666 | __end_cc_report 07:19:48 INFO - PROCESS | 1666 | __startTimestamp1475331588095__endTimestamp 07:19:48 INFO - PROCESS | 1666 | 07:19:48 INFO - PROCESS | 1666 | ------- Summary: start ------- 07:19:48 INFO - PROCESS | 1666 | Number of tests: 6 07:19:48 INFO - PROCESS | 1666 | 07:19:48 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5803.09 Median:6071.57 stddev:701.47 (11.6%) stddev-sans-first:665.15 07:19:48 INFO - PROCESS | 1666 | Values: 2882.3 2903.7 3216.5 3473.0 3494.9 5790.2 5846.6 5878.8 5895.4 5896.0 4844.4 5819.7 5853.9 5890.8 5932.5 5329.3 5368.8 5390.0 5430.8 5430.9 5399.5 5412.5 5436.6 5443.8 5465.4 5283.2 5308.3 5418.8 5431.3 5432.2 5319.3 5338.0 5354.5 5358.8 5368.0 5231.0 5252.8 5315.8 5387.1 5424.3 4585.7 4885.6 5932.2 5955.7 5957.7 4807.4 5533.3 5682.9 6133.1 6196.2 5079.6 5114.9 5595.3 6404.0 6406.9 4538.6 5747.3 5913.0 6056.5 6069.0 6406.6 6412.3 6463.0 6495.5 6510.9 5545.5 5864.9 6242.8 6251.2 6258.0 6184.2 6195.6 6233.5 6343.8 6349.0 6177.5 6232.6 6246.4 6289.1 6325.2 6259.0 6272.5 6280.1 6284.8 6298.6 4893.5 5086.7 5091.2 5091.3 5092.6 4430.1 4450.5 4477.0 4527.4 4572.7 6017.9 6022.5 6045.9 6064.2 6091.7 6165.0 6338.5 6349.4 6350.9 6361.2 5838.9 6032.3 6065.7 6071.6 6107.0 5538.5 5561.2 5563.5 5574.7 5607.6 6521.2 6597.8 6609.7 6616.7 6620.6 6170.2 6223.1 6227.3 6236.1 6292.9 6576.4 6584.8 6589.6 6614.0 6615.5 6248.7 6301.0 6315.0 6323.6 6327.5 6169.2 6179.1 6203.9 6261.3 6279.6 5018.4 6245.3 6256.9 6263.9 6288.4 6222.7 6247.7 6253.9 6258.7 6268.5 5743.6 6072.9 6094.9 6115.7 6117.1 6150.2 6205.6 6229.2 6253.0 6253.1 6109.7 6155.7 6164.7 6179.3 6188.7 07:19:48 INFO - PROCESS | 1666 | 07:19:48 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:72060.08 Median:39754.20 stddev:161643.91 (406.6%) stddev-sans-first:162007.96 07:19:48 INFO - PROCESS | 1666 | Values: 454.6 495.3 513.9 543.1 552.6 31597.4 34894.8 39610.6 39728.8 39779.6 40680.6 41316.0 41408.4 41421.8 41449.0 9589.5 9803.4 9808.5 9828.5 9838.5 9736.6 9835.0 9849.8 9880.7 9928.2 9786.0 9850.0 9857.2 9899.9 9936.9 9796.4 9821.2 9821.6 9845.0 9851.8 9732.2 9846.3 9847.6 9849.7 9854.0 39286.0 39577.6 39590.4 39604.6 39683.4 3431.0 3881.1 3896.5 3934.4 3989.9 29412.6 30003.5 30571.0 31438.7 31814.0 3007.6 3061.6 3168.0 3182.3 3184.9 419815.0 436874.0 506050.0 508580.0 511982.4 61715.7 62141.7 62418.0 62480.1 62696.4 34304.0 35060.3 64496.7 64937.7 65183.7 16361.2 16754.7 16947.0 16954.0 16966.8 12994.1 13039.1 13039.9 13046.3 13050.9 19020.8 19076.6 19091.2 19093.9 19142.3 7581.6 7682.7 8105.9 8226.5 8312.0 800.6 841.9 893.0 980.7 1026.1 29880.8 30242.2 30443.8 30741.0 30852.8 1034.9 1037.4 1060.4 1092.1 1171.1 15431.2 15888.8 15944.3 16160.1 16465.8 683442.0 697284.0 697288.0 698101.0 700990.0 47973.0 48210.8 51379.7 56326.2 57056.4 1245.1 1269.8 1362.4 1373.3 1376.8 23771.3 27196.5 29322.7 30043.7 30673.4 38037.0 49903.8 50010.0 50013.5 50072.5 607273.0 615801.0 617686.0 619752.0 620141.0 25865.5 26273.4 26551.6 26602.7 26668.5 47020.3 47167.8 47733.4 47833.3 48548.8 38837.8 39033.6 40323.0 40611.8 40637.6 39148.0 39292.0 40375.2 40386.0 40473.4 37710.2 37812.1 37988.0 38090.6 38843.4 30561.0 32330.5 32954.0 34201.3 34942.5 25969.0 25989.9 26044.9 26068.7 26476.6 07:19:48 INFO - PROCESS | 1666 | 07:19:48 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34665.40 Median:385.09 stddev:99094.12 (25732.8%) stddev-sans-first:99338.65 07:19:48 INFO - PROCESS | 1666 | Values: 373.9 377.3 384.1 386.0 401.5 18985.1 20642.9 20649.5 20737.7 20899.0 20041.2 20244.5 20574.6 20700.3 20742.4 5968.5 5984.9 6108.7 6113.7 6172.2 4241.3 4463.7 6067.8 6153.9 6157.4 6509.9 6802.4 6862.5 6891.6 6917.2 6619.5 6820.0 6859.8 6864.2 6884.2 5891.1 5981.5 6018.7 6027.5 6036.8 25786.5 26137.5 26164.3 26261.7 26343.9 2352.3 2356.3 2448.4 2478.5 2613.8 14966.9 14999.2 15070.3 15598.0 15961.5 1824.6 1897.4 1909.5 1911.7 1913.3 112805.4 114928.0 115867.0 115889.0 116367.0 9093.2 10904.2 11326.5 11358.4 11459.5 10726.7 14036.9 14084.2 14110.6 14149.4 7384.4 8770.5 8884.6 8913.0 8928.7 7330.3 7424.4 9003.9 9159.7 9171.7 5644.9 6772.1 6840.3 6879.3 6880.5 1447.3 1721.6 1837.9 1868.4 1898.6 842.6 880.2 900.9 941.2 947.4 21701.5 21975.7 22060.8 22171.4 22268.8 935.2 955.8 964.3 979.6 991.6 9715.3 11243.4 11655.0 11812.0 11843.9 571885.0 579549.0 584994.0 619378.0 624615.0 68996.0 72210.0 97818.5 123606.8 136388.3 930.6 931.9 971.1 971.5 1001.0 14780.9 15476.7 17017.6 18621.3 19102.5 45593.0 56613.6 58591.7 58741.7 59863.7 87564.6 87661.6 88068.0 89003.0 89235.6 6770.8 6977.4 8220.2 8250.7 8376.2 11320.9 12962.7 13068.1 13159.9 13396.7 7547.7 11029.6 11124.9 11212.4 11529.0 9933.7 10940.5 11172.6 11348.6 11365.5 11314.9 11354.9 11383.5 11443.3 11565.0 7237.7 7984.0 8136.8 8313.9 8424.9 8313.7 10675.4 10975.3 11221.0 11327.0 07:19:48 INFO - PROCESS | 1666 | 07:19:48 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5851.49 Median:4887.63 stddev:3310.47 (67.7%) stddev-sans-first:3302.47 07:19:48 INFO - PROCESS | 1666 | Values: 1349.7 1514.2 1672.5 1767.3 1816.0 8185.4 8448.9 8797.3 9272.4 9296.9 7721.5 8686.3 9031.6 9089.9 9100.7 2398.7 2430.1 2431.8 2438.0 2443.1 2414.9 2434.8 2461.9 2466.1 2466.3 2420.3 2428.8 2431.9 2450.0 2460.2 2419.6 2426.6 2428.1 2446.0 2450.1 2400.2 2402.7 2406.2 2411.4 2415.0 7584.3 8986.1 9088.7 9098.9 9105.2 4677.3 4912.8 5345.7 5518.4 5524.3 3573.4 3705.8 3721.8 3763.5 3784.5 1081.3 1105.6 1112.4 1128.0 1131.0 12126.7 12303.3 12335.7 12354.3 12374.0 4423.2 4511.5 4823.2 4969.2 5012.4 8811.6 10230.7 10280.6 10358.3 10516.5 5432.7 5477.4 5492.1 5500.3 5500.5 4462.9 4603.8 4862.5 4978.4 5040.4 3561.0 4053.7 4089.3 4114.4 4143.2 1310.8 1319.2 1328.8 1331.7 1336.5 639.6 775.3 908.7 914.5 927.4 5903.4 5987.2 6034.7 6086.5 6200.0 799.8 942.8 972.0 990.9 997.5 3948.8 4061.2 4123.1 4156.4 4169.4 10750.0 11102.4 11227.3 11242.8 11254.0 10875.4 10904.4 11022.1 11127.1 11150.0 8412.6 8532.7 8545.8 8552.6 8580.5 4970.6 5431.6 5978.6 6035.1 6086.4 10206.5 10222.3 10430.5 10454.3 10541.6 9963.9 10348.2 10397.1 10563.8 10572.6 7147.2 7382.5 7533.5 7769.4 7921.6 8418.3 8723.0 8729.2 8763.4 8765.3 7619.8 7720.1 7750.8 7859.5 7868.8 7526.6 7560.8 7593.7 7611.0 7635.5 7079.6 7138.9 7211.9 7216.8 7233.3 4999.1 5035.7 5068.2 5179.0 5295.3 4369.7 5052.3 5101.6 5201.7 5309.9 07:19:48 INFO - PROCESS | 1666 | 07:19:48 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4531.78 Median:4827.47 stddev:1408.28 (29.2%) stddev-sans-first:1375.83 07:19:48 INFO - PROCESS | 1666 | Values: 293.2 306.9 313.5 316.5 319.4 4186.8 4515.2 4831.4 5248.3 5532.7 4683.0 5457.0 5495.7 5523.3 5548.4 4223.7 4251.2 4252.7 4262.8 4265.5 3240.7 4212.9 4267.3 4271.8 4278.1 4193.8 4202.9 4211.9 4212.8 4222.7 4043.7 4199.5 4213.9 4222.4 4240.9 2983.0 3011.8 3434.4 3636.3 3652.4 4058.6 4966.3 5400.8 5416.1 5446.8 4485.5 4593.2 4804.4 4839.5 4852.8 5019.8 5461.8 5822.7 5903.4 5989.6 3660.5 3790.0 3891.9 3987.4 3987.8 5635.6 6170.3 6208.5 6211.0 6279.8 3565.3 4020.5 4033.7 4064.9 4066.3 3915.0 4017.0 4092.4 4100.6 4102.3 4769.5 4769.8 4813.1 4820.1 4831.4 4940.3 5581.7 5912.8 5916.7 5952.0 1165.7 1273.8 1306.2 1323.9 1397.1 783.3 789.3 843.3 855.6 861.7 4529.5 4690.5 4784.2 4823.6 4844.0 5118.8 5127.2 5127.8 5171.3 5212.9 4359.4 4585.4 4596.4 4607.3 4635.9 2654.3 2674.5 2711.7 2723.9 2732.2 5138.5 5210.9 5223.8 5345.9 5370.6 4793.5 4890.5 5029.0 5267.9 5279.3 4193.0 4474.7 4686.9 4813.8 4842.8 4085.0 4431.8 4815.0 4959.3 5135.4 4416.0 4672.3 5062.4 5096.7 5126.6 5892.6 6412.8 6413.9 6435.0 6489.5 4027.7 4061.1 4070.8 4072.0 4084.5 5785.0 5810.8 6025.4 6110.7 6170.0 4753.7 4912.9 5477.0 5807.6 6021.6 5961.0 6010.8 6013.3 6034.9 6094.1 5006.1 5115.8 5778.2 5809.4 5851.8 5939.0 5963.5 5980.3 5993.6 6010.8 5525.9 5649.2 5782.9 5860.4 5882.8 07:19:48 INFO - PROCESS | 1666 | 07:19:48 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:24464.23 Median:13109.68 stddev:39847.52 (304.0%) stddev-sans-first:39919.32 07:19:48 INFO - PROCESS | 1666 | Values: 690.3 734.3 750.7 765.0 806.5 14969.8 15519.9 15542.4 15549.1 15656.4 13978.6 14102.0 14112.3 14146.1 14168.9 808.6 840.3 875.1 878.5 878.5 869.5 870.6 871.6 873.3 875.8 905.4 909.2 913.8 914.1 915.3 868.9 878.8 893.6 904.5 909.1 644.5 664.6 675.6 676.9 678.8 15206.7 15330.8 15468.1 15470.0 15513.9 14142.8 14153.7 14322.9 14347.4 14358.2 11741.7 11897.6 11925.5 12068.4 12493.0 3555.4 3573.8 3738.7 3800.6 3824.3 117771.0 121177.0 122337.0 122532.4 123996.0 10701.9 10798.1 11033.6 11033.8 11181.6 22326.7 22330.6 22439.7 22499.2 22664.0 7965.1 7970.0 7988.4 8094.6 8192.1 4141.1 4359.1 4485.1 4532.9 4553.0 3635.2 3671.1 3753.7 3760.4 3761.2 599.4 613.7 647.5 650.6 676.8 534.6 569.2 573.7 580.9 630.4 8065.4 9075.5 9587.3 9637.9 9703.2 546.3 607.4 613.7 624.6 634.2 4594.2 4704.3 4762.0 4763.2 4781.0 105279.5 120255.0 162761.4 166210.2 169415.0 114028.4 118727.0 124684.0 127595.4 147197.0 105437.0 111409.9 111986.4 112586.9 114307.0 8773.6 9739.7 10169.0 10198.9 10298.0 49191.2 58604.4 60209.0 63740.0 64321.0 63996.4 66199.3 91284.0 94572.5 96991.0 11078.5 11474.9 11507.3 11511.6 11545.4 12158.6 12316.4 12475.1 12540.3 12705.4 11784.9 12017.9 12052.5 12055.3 12447.8 11513.2 11715.9 11948.9 12108.9 12525.2 9492.0 11937.4 12070.0 12080.6 12094.3 9752.0 10122.8 10313.3 10346.4 10410.4 10149.8 10237.8 10329.3 10339.9 10349.9 07:19:48 INFO - PROCESS | 1666 | -------- Summary: end -------- 07:19:48 INFO - PROCESS | 1666 | 07:19:48 INFO - TEST-INFO | 1666: exit 0 07:19:48 INFO - TEST-OK | dromaeo_css | took 1113343ms 07:19:48 INFO - TEST-START | kraken 07:19:48 INFO - operating with platform_type : mac_ 07:19:48 INFO - Initialising browser for kraken test... 07:19:48 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpfWniYo/profile http://localhost:49274/getInfo.html) 07:19:51 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 07:19:51 INFO - PROCESS | 1674 | colorDepth:24 07:19:51 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 07:19:51 INFO - PROCESS | 1674 | __metrics 07:19:51 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 07:19:52 INFO - TEST-INFO | 1674: exit 0 07:19:52 INFO - Browser initialized. 07:19:52 INFO - Running cycle 1/1 for kraken test... 07:19:52 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpfWniYo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:04 INFO - PROCESS | 1676 | RSS: Main: 225021952 07:20:04 INFO - PROCESS | 1676 | 07:20:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 07:20:08 INFO - PROCESS | 1676 | RSS: Main: 237490176 07:20:08 INFO - PROCESS | 1676 | 07:20:11 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 07:20:11 INFO - PROCESS | 1676 | RSS: Main: 244932608 07:20:11 INFO - PROCESS | 1676 | 07:20:14 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 07:20:15 INFO - PROCESS | 1676 | RSS: Main: 248688640 07:20:15 INFO - PROCESS | 1676 | 07:20:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 07:20:18 INFO - PROCESS | 1676 | RSS: Main: 250044416 07:20:18 INFO - PROCESS | 1676 | 07:20:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:20:20 INFO - PROCESS | 1676 | RSS: Main: 250146816 07:20:20 INFO - PROCESS | 1676 | 07:20:23 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 07:20:24 INFO - PROCESS | 1676 | RSS: Main: 251121664 07:20:24 INFO - PROCESS | 1676 | 07:20:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 07:20:27 INFO - PROCESS | 1676 | RSS: Main: 250736640 07:20:27 INFO - PROCESS | 1676 | 07:20:30 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 07:20:30 INFO - PROCESS | 1676 | RSS: Main: 251449344 07:20:30 INFO - PROCESS | 1676 | 07:20:32 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:33 INFO - PROCESS | 1676 | RSS: Main: 251015168 07:20:33 INFO - PROCESS | 1676 | 07:20:34 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:35 INFO - PROCESS | 1676 | RSS: Main: 251097088 07:20:35 INFO - PROCESS | 1676 | 07:20:37 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:38 INFO - PROCESS | 1676 | RSS: Main: 251047936 07:20:38 INFO - PROCESS | 1676 | 07:20:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:42 INFO - PROCESS | 1676 | RSS: Main: 251092992 07:20:42 INFO - PROCESS | 1676 | 07:20:45 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:45 INFO - PROCESS | 1676 | RSS: Main: 251502592 07:20:45 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 07:20:47 INFO - PROCESS | 1676 | RSS: Main: 252932096 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | __start_tp_report 07:20:47 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 07:20:47 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 07:20:47 INFO - PROCESS | 1676 | |i|pagename|runs| 07:20:47 INFO - PROCESS | 1676 | |0;ai-astar;104;133;176;158;120;118;119;120;159;177 07:20:47 INFO - PROCESS | 1676 | |1;audio-beat-detection;143;137;141;145;136;145;97;133;176;145 07:20:47 INFO - PROCESS | 1676 | |2;audio-dft;194;196;196;199;193;194;196;226;263;196 07:20:47 INFO - PROCESS | 1676 | |3;audio-fft;82;59;58;82;61;59;59;58;78;60 07:20:47 INFO - PROCESS | 1676 | |4;audio-oscillator;90;69;88;69;69;70;86;69;71;88 07:20:47 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;90;87;89;86;89;86;111;104;89;86 07:20:47 INFO - PROCESS | 1676 | |6;imaging-darkroom;96;97;96;97;120;139;125;97;96;97 07:20:47 INFO - PROCESS | 1676 | |7;imaging-desaturate;92;93;91;89;93;90;91;93;90;92 07:20:47 INFO - PROCESS | 1676 | |8;json-parse-financial;56;55;55;56;59;57;58;59;60;59 07:20:47 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;66;68;72;67;75;70;65;63;67;72 07:20:47 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;103;102;107;104;97;101;106;103;85;84 07:20:47 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;121;141;142;125;139;152;163;140;196;138 07:20:47 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;164;166;164;164;167;164;169;175;167;163 07:20:47 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;66;67;69;67;66;69;69;68;67;67 07:20:47 INFO - PROCESS | 1676 | __end_tp_report 07:20:47 INFO - PROCESS | 1676 | __start_cc_report 07:20:47 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,943 07:20:47 INFO - PROCESS | 1676 | __end_cc_report 07:20:47 INFO - PROCESS | 1676 | __startTimestamp1475331647569__endTimestamp 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | ------- Summary: start ------- 07:20:47 INFO - PROCESS | 1676 | Number of tests: 14 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:138.40 Median:145.50 stddev:26.65 (18.3%) stddev-sans-first:25.20 07:20:47 INFO - PROCESS | 1676 | Values: 104.0 133.0 176.0 158.0 120.0 118.0 119.0 120.0 159.0 177.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:145.00 stddev:19.16 (13.2%) stddev-sans-first:20.29 07:20:47 INFO - PROCESS | 1676 | Values: 143.0 137.0 141.0 145.0 136.0 145.0 97.0 133.0 176.0 145.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:205.30 Median:196.00 stddev:22.48 (11.5%) stddev-sans-first:23.47 07:20:47 INFO - PROCESS | 1676 | Values: 194.0 196.0 196.0 199.0 193.0 194.0 196.0 226.0 263.0 196.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.50 stddev:10.49 (17.3%) stddev-sans-first:9.30 07:20:47 INFO - PROCESS | 1676 | Values: 82.0 59.0 58.0 82.0 61.0 59.0 59.0 58.0 78.0 60.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:78.50 stddev:9.62 (12.3%) stddev-sans-first:8.96 07:20:47 INFO - PROCESS | 1676 | Values: 90.0 69.0 88.0 69.0 69.0 70.0 86.0 69.0 71.0 88.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:91.70 Median:88.00 stddev:8.62 (9.8%) stddev-sans-first:9.12 07:20:47 INFO - PROCESS | 1676 | Values: 90.0 87.0 89.0 86.0 89.0 86.0 111.0 104.0 89.0 86.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:106.00 Median:96.50 stddev:15.88 (16.5%) stddev-sans-first:16.43 07:20:47 INFO - PROCESS | 1676 | Values: 96.0 97.0 96.0 97.0 120.0 139.0 125.0 97.0 96.0 97.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:91.40 Median:92.00 stddev:1.43 (1.6%) stddev-sans-first:1.50 07:20:47 INFO - PROCESS | 1676 | Values: 92.0 93.0 91.0 89.0 93.0 90.0 91.0 93.0 90.0 92.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.50 stddev:1.84 (3.1%) stddev-sans-first:1.88 07:20:47 INFO - PROCESS | 1676 | Values: 56.0 55.0 55.0 56.0 59.0 57.0 58.0 59.0 60.0 59.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:3.69 (5.3%) stddev-sans-first:3.80 07:20:47 INFO - PROCESS | 1676 | Values: 66.0 68.0 72.0 67.0 75.0 70.0 65.0 63.0 67.0 72.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:99.20 Median:106.50 stddev:8.22 (7.7%) stddev-sans-first:8.60 07:20:47 INFO - PROCESS | 1676 | Values: 103.0 102.0 107.0 104.0 97.0 101.0 106.0 103.0 85.0 84.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:141.50 stddev:21.29 (15.0%) stddev-sans-first:20.62 07:20:47 INFO - PROCESS | 1676 | Values: 121.0 141.0 142.0 125.0 139.0 152.0 163.0 140.0 196.0 138.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.50 stddev:3.59 (2.2%) stddev-sans-first:3.71 07:20:47 INFO - PROCESS | 1676 | Values: 164.0 166.0 164.0 164.0 167.0 164.0 169.0 175.0 167.0 163.0 07:20:47 INFO - PROCESS | 1676 | 07:20:47 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.18 (1.7%) stddev-sans-first:1.12 07:20:47 INFO - PROCESS | 1676 | Values: 66.0 67.0 69.0 67.0 66.0 69.0 69.0 68.0 67.0 67.0 07:20:47 INFO - PROCESS | 1676 | -------- Summary: end -------- 07:20:47 INFO - PROCESS | 1676 | 07:20:48 INFO - TEST-INFO | 1676: exit 0 07:20:48 INFO - TEST-OK | kraken | took 59790ms 07:20:48 INFO - SUITE-END | took 1173s 07:20:48 INFO - Completed test suite (00:19:33) 07:20:48 INFO - javascript benchmark 07:20:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7400.201215274999, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2882.293838009688, 2903.7241462061097, 3216.469282568376, 3472.9652703472957, 3494.912627184321, 5790.160426738125, 5846.56150788691, 5878.794242201524, 5895.439933206349, 5896.0, 4844.418669759634, 5819.67991760453, 5853.8829223415505, 5890.823275301748, 5932.525397968163, 5329.333833270851, 5368.758405871745, 5390.0, 5430.755615997289, 5430.91853622196, 5399.487048730364, 5412.4587541245955, 5436.565074794027, 5443.755031023614, 5465.371482279549, 5283.177303830192, 5308.283381743454, 5418.783248670048, 5431.266778984846, 5432.185172224158, 5319.281896943921, 5337.973310133424, 5354.4645535446725, 5358.758855851496, 5368.006918720011, 5230.973845130788, 5252.763625636855, 5315.760790764425, 5387.057264978613, 5424.321959755031, 4585.7248565085865, 4885.6335774817035, 5932.199153114318, 5955.731992060368, 5957.672328021957, 4807.423109226916, 5533.335999680065, 5682.920245153449, 6133.059244993061, 6196.1635179251125, 5079.619028572835, 5114.900296436247, 5595.272614560122, 6404.007378856285, 6406.93593064068, 4538.614217791492, 5747.281589801317, 5913.0, 6056.515478761688, 6068.969655151696, 6406.5515413920575, 6412.294647588761, 6462.967685161544, 6495.512836537184, 6510.934890651033, 5545.473180047889, 5864.8533786654825, 6242.812715618538, 6251.156093927352, 6257.9687101564205, 6184.196054512974, 6195.566310358322, 6233.470155036782, 6343.809685709436, 6349.015902535114, 6177.536684748572, 6232.626042437469, 6246.406591373812, 6289.056641503811, 6325.209348831396, 6258.967270400333, 6272.466840318624, 6280.089387038854, 6284.780032698834, 6298.622082675054, 4893.486183950705, 5086.694798312114, 5091.1854103343285, 5091.3126727892, 5092.567131793839, 4430.113977204572, 4450.532694067077, 4476.955230447654, 4527.388802511685, 4572.74849883253, 6017.909731354033, 6022.5483088768515, 6045.879082418327, 6064.211652485149, 6091.725872335755, 6164.969175154096, 6338.461230795342, 6349.396807303298, 6350.904736428957, 6361.173047503888, 5838.9124163137585, 6032.336442991267, 6065.666388348595, 6071.574989750675, 6106.969465152646, 5538.501534861801, 5561.249231353796, 5563.5271001964475, 5574.721263936787, 5607.579431542651, 6521.184851893513, 6597.835054123493, 6609.702563384563, 6616.669166541654, 6620.602763834186, 6170.197874276315, 6223.097650840693, 6227.346128656426, 6236.095766113797, 6292.937070629235, 6576.375244351779, 6584.8024559261385, 6589.571677840925, 6614.0, 6615.503837212132, 6248.687565621792, 6300.9684951574945, 6315.021171718391, 6323.588966717149, 6327.525435592257, 6169.2288463942, 6179.134921111138, 6203.914314994948, 6261.279952805486, 6279.560430769802, 5018.3977922648055, 6245.281792593728, 6256.874862502634, 6263.937360626518, 6288.434040936338, 6222.688865556614, 6247.68761561911, 6253.906191407224, 6258.655773932477, 6268.498520118471, 5743.59794814359, 6072.878542429038, 6094.939050609437, 6115.694215289307, 6117.0824376342125, 6150.200473938538, 6205.596636218631, 6229.221347331583, 6253.0, 6253.09330147117, 6109.725062372115, 6155.692215389302, 6164.6917654118015, 6179.258488981351, 6188.659623720739], "value": 5757.552762847157, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.62039197270275, 495.3065708008787, 513.8694871283178, 543.0849019402308, 552.593843525009, 31597.368052638933, 34894.825525872366, 39610.60389396105, 39728.801355993215, 39779.602203977985, 40680.59319406805, 41316.0, 41408.378874316906, 41421.792891035504, 41448.96377590562, 9589.520523973808, 9803.41179529227, 9808.50957452128, 9828.508574571242, 9838.458884761336, 9736.610535578604, 9835.01649835018, 9849.753756156082, 9880.703578892644, 9928.156106730936, 9786.0, 9849.965753595841, 9857.162141218005, 9899.851502227473, 9936.850947235796, 9796.412215267072, 9821.165200957927, 9821.607135714563, 9844.950775246078, 9851.753706157404, 9732.172765314957, 9846.261530385178, 9847.60609575616, 9849.704508864674, 9854.0, 39286.0, 39577.60422395768, 39590.406143907865, 39604.603953960665, 39683.40474892879, 3431.0, 3881.0879443330796, 3896.5129358830145, 3934.449177115206, 3989.880303590897, 29412.558811617844, 30003.549946750816, 30571.0, 31438.74245030219, 31814.04557863268, 3007.624046994126, 3061.5866857974333, 3168.0495851244536, 3182.315802102536, 3184.8885289015006, 419815.0, 436874.0, 506050.0, 508580.0, 511982.4400877972, 61715.69142154261, 62141.68929155325, 62418.0, 62480.06279905805, 62696.373036269055, 34304.0, 35060.298794024486, 64496.677516612115, 64937.67531162409, 65183.67408162929, 16361.181940903145, 16754.74867876983, 16946.98318100918, 16954.0, 16966.830331696772, 12994.090413671142, 13039.087263891626, 13039.869601304055, 13046.347682615831, 13050.934745326402, 19020.809791901906, 19076.61846763057, 19091.2363505461, 19093.90453047726, 19142.330018449287, 7581.6209189541405, 7682.692692292246, 8105.918940810634, 8226.547539885363, 8312.04411492686, 800.5756948817136, 841.8610929196614, 893.0444424465759, 980.7155924781733, 1026.0867827633263, 29880.78126321135, 30242.24394390114, 30443.847780761396, 30741.0, 30852.845735771178, 1034.9327293725885, 1037.3827572594294, 1060.3955745225148, 1092.093562343253, 1171.1275100050516, 15431.228438578026, 15888.841111588967, 15944.2825072872, 16160.111193884213, 16465.83534164667, 683442.0, 697284.0, 697288.0, 698101.0, 700990.0, 47973.0, 48210.758946205046, 51379.74310128426, 56326.15510767342, 57056.42943570594, 1245.1470742541387, 1269.7587458382877, 1362.3664995777012, 1373.2858913364994, 1376.7521846067605, 23771.286861394186, 27196.456070878077, 29322.706772931997, 30043.699563004964, 30673.38653226878, 38037.0, 49903.75048124736, 50010.0, 50013.49932503433, 50072.49927500824, 607273.0, 615801.0, 617686.0, 619752.0, 620141.0, 25865.482690346464, 26273.423594584387, 26551.601725974513, 26602.733972660026, 26668.466630667666, 47020.29469557891, 47167.76416117897, 47733.419993499934, 47833.28250076182, 48548.78628034327, 38837.80581097076, 39033.609663903, 40322.99664702507, 40611.796941015105, 40637.59362406338, 39148.0212994666, 39292.01769955774, 40375.1924961505, 40386.0, 40473.39289910712, 37710.24579508339, 37812.05469863275, 37988.0, 38090.61909380871, 38843.41734874035, 30561.0, 32330.515042273913, 32954.0, 34201.343887703704, 34942.475862862586, 25969.0, 25989.87005065038, 26044.869775651, 26068.73931260663, 26476.602850957635], "value": 19995.575384290907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.89717827597406, 377.31153089922583, 384.1299456730505, 386.0464652308796, 401.5241938303111, 18985.14566844492, 20642.89678551607, 20649.483762905937, 20737.688934665992, 20899.0, 20041.198352065938, 20244.493887652818, 20574.588508229826, 20700.27549035784, 20742.377728668125, 5968.522518198544, 5984.88030239395, 6108.725107370156, 6113.6943152842405, 6172.1667574877265, 4241.34259189826, 4463.687541872054, 6067.848303792419, 6153.9384606154035, 6157.384261573851, 6509.925862232726, 6802.38778509934, 6862.451003919675, 6891.552049116816, 6917.204521480044, 6619.4704423646235, 6820.045193672865, 6859.759908403182, 6864.2106157791995, 6884.242733299333, 5891.116332550109, 5981.52147828177, 6018.6990650467305, 6027.487663548603, 6036.758529658809, 25786.48427031449, 26137.477250455075, 26164.34589135287, 26261.73738262612, 26343.94624215029, 2352.270796053229, 2356.2813341930705, 2448.43685952232, 2478.491909158618, 2613.751693589106, 14966.925165374212, 14999.1750453725, 15070.321835517429, 15597.986130901456, 15961.521154365271, 1824.6350729854082, 1897.3928342930267, 1909.5321646196771, 1911.7419148415065, 1913.3016448996016, 112805.43597282043, 114928.0, 115867.0, 115889.0, 116367.0, 9093.22707569864, 10904.236703430684, 11326.490307936163, 11358.432078396047, 11459.45297384859, 10726.678199654023, 14036.859631403555, 14084.15495070299, 14110.576682699535, 14149.363278652485, 7384.409247260206, 8770.473771573726, 8884.555772211364, 8913.019567847532, 8928.73213803587, 7330.340269375782, 7424.443166762514, 9003.909960900308, 9159.725208243763, 9171.724848254564, 5644.943550564524, 6772.11962444879, 6840.281770414134, 6879.3120687930805, 6880.483963702743, 1447.254663848119, 1721.5954250751063, 1837.86216033798, 1868.374094678298, 1898.5633304340079, 842.5787106446777, 880.1682410122501, 900.9009009009004, 941.1952780372819, 947.3652652722692, 21701.457463563536, 21975.670364944537, 22060.779392206194, 22171.445713857283, 22268.7752173632, 935.2050756856618, 955.8422860227985, 964.3490643815537, 979.6424305128577, 991.6231831903831, 9715.319927605142, 11243.381614011145, 11655.0, 11812.0, 11843.940780296043, 571885.0, 579549.0, 584994.0, 619378.0, 624615.0, 68996.0, 72210.0, 97818.53272200923, 123606.76393236133, 136388.31805841107, 930.5951910918772, 931.9440833550009, 971.1308379000895, 971.5433746139303, 1000.9949950250348, 14780.852191477947, 15476.690466190837, 17017.57456063559, 18621.348252811087, 19102.522436939187, 45593.0, 56613.58466038382, 58591.70704146452, 58741.70629146827, 59863.70068149632, 87564.56217718871, 87661.56169219113, 88068.0, 89003.0, 89235.55382223047, 6770.830729231809, 6977.441804655514, 8220.219079187467, 8250.711225107092, 8376.162383761575, 11320.943395282971, 12962.740745184854, 13068.085234033526, 13159.93420032932, 13396.732065358834, 7547.660355283915, 11029.61396351124, 11124.944375278072, 11212.383318917538, 11529.020033296929, 9933.701988940344, 10940.45297735126, 11172.608958686407, 11348.602798901999, 11365.48855301497, 11314.943425282821, 11354.886451135713, 11383.487743051417, 11443.313401195623, 11565.016973557342, 7237.710491580277, 7984.0, 8136.75589732309, 8313.916860831314, 8424.873626895478, 8313.6674533018, 10675.412852293199, 10975.341479511255, 11221.046211071824, 11327.037201837606], "value": 9769.233327702974, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.6895713985787, 1514.2050423527646, 1672.4731709511502, 1767.3372485318005, 1816.0465755478365, 8185.386096042791, 8448.873266901, 8797.296216302688, 9272.443653380802, 9296.90703092969, 7721.498102623325, 8686.348523860705, 9031.638734450615, 9089.863652045224, 9100.681476148337, 2398.73613902471, 2430.1130087518104, 2431.7932975697086, 2438.036975394718, 2443.059422122478, 2414.915477958272, 2434.805215582749, 2461.9261422157365, 2466.124525793344, 2466.2847774145475, 2420.334408037786, 2428.8178386620984, 2431.8540887546715, 2449.9755002449924, 2460.2496238647204, 2419.637054441839, 2426.6360045993065, 2428.077330614373, 2446.0338166424162, 2450.1424501424535, 2400.1599440195964, 2402.6636270922086, 2406.2420337593776, 2411.4333131714034, 2415.0460568075687, 7584.317411432942, 8986.14631609996, 9088.68189613367, 9098.86351704725, 9105.180533751927, 4677.345171675934, 4912.77892494835, 5345.705986170759, 5518.448155184489, 5524.254225679522, 3573.4282514797505, 3705.7776533407814, 3721.813909304524, 3763.510743603314, 3784.4701741756176, 1081.2701426537055, 1105.618561596248, 1112.3770688414434, 1128.0242590159535, 1130.9943450282697, 12126.696832579168, 12303.32331721746, 12335.691607709789, 12354.25874447536, 12374.0, 4423.18171138334, 4511.548573011404, 4823.2282834746275, 4969.155243608595, 5012.423571289275, 8811.559422028873, 10230.744231394274, 10280.640177593898, 10358.326708763907, 10516.526756295985, 5432.674039557639, 5477.384171669367, 5492.066348720727, 5500.312460942382, 5500.532454741392, 4462.866114016585, 4603.792829322621, 4862.489438608965, 4978.377702787152, 5040.445550989388, 3561.0207193022125, 4053.70281509914, 4089.3048181809163, 4114.423980642652, 4143.212789569972, 1310.7902735562263, 1319.162331919219, 1328.8338957630297, 1331.7403106394354, 1336.5054929675887, 639.5555089213045, 775.337086790797, 908.6955869783696, 914.5061666700041, 927.3879239701764, 5903.380145084704, 5987.191729116601, 6034.698265086816, 6086.543509236825, 6200.0, 799.8160423102719, 942.8114377124602, 971.9902800972042, 990.9355891867006, 997.4912794474725, 3948.763074215499, 4061.1674606705556, 4123.072308730511, 4156.376543518496, 4169.374593810952, 10750.0, 11102.389368584805, 11227.326360418401, 11242.775144497227, 11253.987141157335, 10875.401852898009, 10904.400257985728, 11022.063124634336, 11127.054200392895, 11150.0, 8412.621432035574, 8532.701355452653, 8545.786355341166, 8552.572371381406, 8580.485170889891, 4970.577500912318, 5431.619786615057, 5978.581499295007, 6035.064564992434, 6086.421789929949, 10206.489675516046, 10222.335548189343, 10430.478476076318, 10454.32046916948, 10541.57833686644, 9963.900360996297, 10348.172146228133, 10397.116245118947, 10563.841542377024, 10572.629957951434, 7147.213806481387, 7382.52013619113, 7533.510321829063, 7769.378449723896, 7921.564313962787, 8418.326533877398, 8722.99685536146, 8729.170728780755, 8763.430377025474, 8765.34259930495, 7619.847603048019, 7720.073591169095, 7750.844983100419, 7859.52842829432, 7868.763937081897, 7526.5860377679755, 7560.8487830244185, 7593.734219302298, 7611.0, 7635.541867487968, 7079.610621415872, 7138.892916606152, 7211.891821622575, 7216.819579510554, 7233.31283528064, 4999.125153098266, 5035.748212589429, 5068.21442676371, 5178.974105129601, 5295.25866378715, 4369.7159684621665, 5052.252682238054, 5101.627743099477, 5201.713905735221, 5309.920351194658], "value": 4687.960546728514, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.19956518703935, 306.90946170879573, 313.5344014139003, 316.52205170193014, 319.4170638584584, 4186.811593478294, 4515.232410490216, 4831.396075490564, 5248.317718696569, 5532.668039917603, 4682.953170468294, 5457.017736807373, 5495.725213739317, 5523.337199536061, 5548.44515548445, 4223.66210703143, 4251.2135254977775, 4252.746044596369, 4262.78686065697, 4265.530791612936, 3240.7245384142375, 4212.894677633069, 4267.317229243322, 4271.807768650403, 4278.080212754257, 4193.790310484479, 4202.852900148496, 4211.873643790691, 4212.789360531977, 4222.662187025031, 4043.696722745806, 4199.496060472763, 4213.936790948138, 4222.408862759216, 4240.893977650552, 2983.015604850394, 3011.8494075296367, 3434.4161492546327, 3636.2909432566653, 3652.4338727497015, 4058.5738497457637, 4966.329545511346, 5400.756965936543, 5416.1063424534905, 5446.754896029688, 4485.484169320504, 4593.208648627038, 4804.357603318161, 4839.516048395168, 4852.805887764485, 5019.799208031674, 5461.808836690737, 5822.7088645567555, 5903.35063143054, 5989.64062156272, 3660.5058317127114, 3790.0102446215683, 3891.8637847675477, 3987.362022076483, 3987.760734355948, 5635.6055076144685, 6170.259568851721, 6208.5033197344555, 6210.962874131806, 6279.780207692709, 3565.2512972276113, 4020.537638171648, 4033.69747268956, 4064.898377540526, 4066.3493840985893, 3915.031671551329, 4016.9598304016586, 4092.4475195848777, 4100.610442008005, 4102.261592913304, 4769.499202583748, 4769.758213639584, 4813.125434025573, 4820.096062055469, 4831.371921650233, 4940.258961155783, 5581.6930068846605, 5912.76348946046, 5916.73374698131, 5951.958407278709, 1165.7085728567858, 1273.8216649669055, 1306.1901620995043, 1323.8676132386877, 1397.1407584335764, 783.3302526340011, 789.3487872505207, 843.2958479669422, 855.5593869157389, 861.6510313323114, 4529.547045295444, 4690.460597031385, 4784.210605250095, 4823.5658790709, 4843.975780121077, 5118.769655365518, 5127.179851152787, 5127.79488820443, 5171.301874247004, 5212.921806172911, 4359.411479450297, 4585.426821647294, 4596.37948876904, 4607.308903664477, 4635.890669745258, 2654.336415896026, 2674.5185866544207, 2711.667965549626, 2723.850188239666, 2732.221316924667, 5138.460461651547, 5210.925553923204, 5223.817166399158, 5345.893082138336, 5370.630489225223, 4793.5307625306505, 4890.462049174588, 5029.0, 5267.868303292448, 5279.340082489689, 4192.979035104805, 4474.6867719259335, 4686.851721328228, 4813.831515896997, 4842.789302674331, 4084.9795751021056, 4431.828404082041, 4814.975925120352, 4959.330490383752, 5135.408023512723, 4415.977920110379, 4672.322513235494, 5062.443131255633, 5096.668716533413, 5126.564242039469, 5892.587518873637, 6412.775552855815, 6413.8834184718, 6435.0, 6489.480841532761, 4027.7381970171846, 4061.0659548304648, 4070.75575465473, 4071.959280407158, 4084.4690190275073, 5784.971075144597, 5810.767569297181, 6025.427584379477, 6110.686202466491, 6170.0, 4753.716496545982, 4912.85261442143, 5477.0, 5807.573531616366, 6021.608595441282, 5960.956832554199, 6010.819675409744, 6013.30846952606, 6034.879302414015, 6094.055421409688, 5006.123928312458, 5115.820946266863, 5778.219940308173, 5809.419058094157, 5851.824445266649, 5938.990371636745, 5963.52291816645, 5980.308861012475, 5993.572603095753, 6010.819675409744, 5525.861853453695, 5649.180868774087, 5782.942170578409, 5860.443257890493, 5882.764689412375], "value": 4079.023976395538, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.3027941778802, 734.2694019450647, 750.6884642873208, 764.9502782319149, 806.5201205282857, 14969.775453368195, 15519.92240038801, 15542.378304867792, 15549.067055976635, 15656.3737450502, 13978.580642580739, 14102.012859099841, 14112.29438528072, 14146.080504767184, 14168.929155354235, 808.5633757770811, 840.260570697785, 875.0811647769848, 878.5343767803042, 878.5431575580694, 869.5043825019741, 870.5951732444412, 871.559862269553, 873.3449912565576, 875.829213303406, 905.4431524612381, 909.2180724576858, 913.8218047480744, 914.1498406481969, 915.2906497464452, 868.9217970382696, 878.793483531376, 893.6112790935931, 904.5070436611996, 909.1045320359441, 644.5101722690742, 664.5945972956492, 675.5743881354715, 676.9289224631441, 678.8099332186996, 15206.695866082617, 15330.846691533165, 15468.14925179126, 15470.0, 15513.922430387776, 14142.787858182135, 14153.716925661533, 14322.856771432256, 14347.354369053313, 14358.210298433582, 11741.706457338549, 11897.643070707893, 11925.463354149084, 12068.396580170956, 12493.0, 3555.3600351936643, 3573.803440810754, 3738.719596030309, 3800.619938006205, 3824.2542704172697, 117771.0, 121177.0, 122337.0, 122532.38733806364, 123996.0, 10701.946490267499, 10798.136149108053, 11033.6138235163, 11033.779324413466, 11181.552737890555, 22326.665100023514, 22330.55338893213, 22439.663405048937, 22499.212527561456, 22664.0, 7965.084015338311, 7970.0, 7988.400869934778, 8094.595270236465, 8192.098869124391, 4141.130362623822, 4359.12817436514, 4485.0581377911, 4532.864014079517, 4552.954470455319, 3635.163912300186, 3671.0822294426393, 3753.7184711146774, 3760.435934609776, 3761.153740408386, 599.4005994005994, 613.7357044488368, 647.4626060369882, 650.629141389413, 676.8307923019245, 534.569671414515, 569.2002736155708, 573.7183311458451, 580.8896309701144, 630.4263120560269, 8065.354771618257, 9075.500847453453, 9587.328886977984, 9637.9036209637, 9703.24778537581, 546.336201515161, 607.3683369295883, 613.6502193749609, 624.6096189881324, 634.22307673101, 4594.173048851172, 4704.317873908264, 4761.95238047622, 4763.214069678534, 4781.0, 105279.4736026315, 120255.0, 162761.37238627463, 166210.16894915447, 169415.0, 114028.42985785018, 118727.0, 124684.0, 127595.44809103766, 147197.0, 105437.0, 111409.88590113995, 111986.44006779914, 112586.87413125765, 114307.0, 8773.561321934005, 9739.707808765748, 10169.03394177552, 10198.898011019795, 10298.0, 49191.23930022285, 58604.4139558616, 60209.0, 63740.0, 64321.0, 63996.36003639904, 66199.33800661932, 91284.0, 94572.52713736387, 96991.0, 11078.501467433824, 11474.885251147381, 11507.252028618113, 11511.597094101666, 11545.36500492481, 12158.574449894211, 12316.445759941003, 12475.126741128033, 12540.310282934526, 12705.428255728699, 11784.882151178379, 12017.939910300393, 12052.457639406073, 12055.276683399024, 12447.813282800584, 11513.194076414571, 11715.941420292844, 11948.940255298668, 12108.878911211128, 12525.248485090924, 9491.952540237531, 11937.403129843648, 12070.0, 12080.577179798665, 12094.274343539415, 9751.951240243754, 10122.848157277795, 10313.27807053499, 10346.430946297725, 10410.375377477376, 10149.797004060025, 10237.795244095225, 10329.328593641389, 10339.948300258451, 10349.896501034893], "value": 7635.60037380772, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 133.0, 176.0, 158.0, 120.0, 118.0, 119.0, 120.0, 159.0, 177.0], "value": 138.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 137.0, 141.0, 145.0, 136.0, 145.0, 97.0, 133.0, 176.0, 145.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 196.0, 196.0, 199.0, 193.0, 194.0, 196.0, 226.0, 263.0, 196.0], "value": 205.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 82.0, 61.0, 59.0, 59.0, 58.0, 78.0, 60.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 88.0, 69.0, 69.0, 70.0, 86.0, 69.0, 71.0, 88.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 86.0, 89.0, 86.0, 111.0, 104.0, 89.0, 86.0], "value": 91.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 120.0, 139.0, 125.0, 97.0, 96.0, 97.0], "value": 106.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 91.0, 89.0, 93.0, 90.0, 91.0, 93.0, 90.0, 92.0], "value": 91.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 59.0, 57.0, 58.0, 59.0, 60.0, 59.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 72.0, 67.0, 75.0, 70.0, 65.0, 63.0, 67.0, 72.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 102.0, 107.0, 104.0, 97.0, 101.0, 106.0, 103.0, 85.0, 84.0], "value": 99.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 141.0, 142.0, 125.0, 139.0, 152.0, 163.0, 140.0, 196.0, 138.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 164.0, 164.0, 167.0, 164.0, 169.0, 175.0, 167.0, 163.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 67.0, 66.0, 69.0, 69.0, 68.0, 67.0, 67.0], "value": 67.5, "unit": "score"}]}]} 07:20:48 INFO - Return code: 0 07:20:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:20:48 ERROR - # TBPL SUCCESS # 07:20:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:20:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:20:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:20:48 INFO - 2016-10-01 07:20:48.914 screenresolution[1681:11476] starting screenresolution argv=screenresolution get 07:20:48 INFO - 2016-10-01 07:20:48.917 screenresolution[1681:11476] Display 0: 1600x1200x32@60 07:20:48 INFO - 2016-10-01 07:20:48.923 screenresolution[1682:11479] starting screenresolution argv=screenresolution list 07:20:48 INFO - Available Modes on Display 0 07:20:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:20:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:20:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:20:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:20:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:20:49 INFO - Intel Iris: 07:20:49 INFO - Chipset Model: Intel Iris 07:20:49 INFO - Type: GPU 07:20:49 INFO - Bus: Built-In 07:20:49 INFO - VRAM (Dynamic, Max): 1536 MB 07:20:49 INFO - Vendor: Intel (0x8086) 07:20:49 INFO - Device ID: 0x0a2e 07:20:49 INFO - Revision ID: 0x0009 07:20:49 INFO - Displays: 07:20:49 INFO - Display: 07:20:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:20:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:20:49 INFO - Display Serial Number: 1600x1200 60 07:20:49 INFO - Main Display: Yes 07:20:49 INFO - Mirror: Off 07:20:49 INFO - Online: Yes 07:20:49 INFO - Rotation: Supported 07:20:49 INFO - Return code: 0 07:20:49 INFO - Running post-action listener: _resource_record_post_action 07:20:49 INFO - [mozharness: 2016-10-01 14:20:49.160719Z] Finished run-tests step (success) 07:20:49 INFO - Running post-run listener: _resource_record_post_run 07:20:49 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 32025600; Write bytes: 665789440; Read time: 196; Write time: 1895 07:20:49 INFO - TinderboxPrint: CPU usage
54.3% 07:20:49 INFO - TinderboxPrint: I/O read bytes / time
32,025,600 / 196 07:20:49 INFO - TinderboxPrint: I/O write bytes / time
665,789,440 / 1,895 07:20:49 INFO - TinderboxPrint: CPU idle
2,207.4 (45.7%) 07:20:49 INFO - TinderboxPrint: CPU system
973.6 (20.2%) 07:20:49 INFO - TinderboxPrint: CPU user
1,644.6 (34.1%) 07:20:49 INFO - TinderboxPrint: Swap in / out
391,872,512 / 0 07:20:49 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356035072; Write bytes: 355747328; Read time: 27437; Write time: 721 07:20:49 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 30268416; Write bytes: 299023872; Read time: 182; Write time: 1137 07:20:49 INFO - Running post-run listener: _upload_blobber_files 07:20:49 INFO - Blob upload gear active. 07:20:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:20:49 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 07:20:49 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'] 07:20:49 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 07:20:50 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:20:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:20:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:50 INFO - (blobuploader) - INFO - Done attempting. 07:20:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:20:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:20:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:51 INFO - (blobuploader) - INFO - Done attempting. 07:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:20:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:54 INFO - (blobuploader) - INFO - Done attempting. 07:20:54 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:54 INFO - Return code: 0 07:20:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:20:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f63bb99be423b00501c7db110e89cd041d3195395739c683ce08f4a1e855a5004edc1253486b21467dc7dacf3069136f30dc58e2f3a69a54a37b4c7bb3ec2e89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7b05c10a708cf954f66aa0055eaaa07a4c341ce7d563c9b88f06e4e6b23e1f8eef7308bbd4aea2984bf3ebe1604c3e2c1427c174356dac45305245f1b22ab68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d786b6a7764e77de5b676f4366eab749a81dd8ad568c7f25c0c300a2a848a4368444ec8a1010f8aca99469c7e68538754c159638a363d74151367f6014bb4321"} 07:20:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:20:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:20:54 INFO - Contents: 07:20:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f63bb99be423b00501c7db110e89cd041d3195395739c683ce08f4a1e855a5004edc1253486b21467dc7dacf3069136f30dc58e2f3a69a54a37b4c7bb3ec2e89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7b05c10a708cf954f66aa0055eaaa07a4c341ce7d563c9b88f06e4e6b23e1f8eef7308bbd4aea2984bf3ebe1604c3e2c1427c174356dac45305245f1b22ab68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d786b6a7764e77de5b676f4366eab749a81dd8ad568c7f25c0c300a2a848a4368444ec8a1010f8aca99469c7e68538754c159638a363d74151367f6014bb4321"} 07:20:54 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:54 INFO - Copying logs to upload dir... 07:20:54 INFO - mkdir: /builds/slave/test/build/upload/logs 07:20:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.068813 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-01 07:20:54.356119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 07:20:54.361325) ========= 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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f63bb99be423b00501c7db110e89cd041d3195395739c683ce08f4a1e855a5004edc1253486b21467dc7dacf3069136f30dc58e2f3a69a54a37b4c7bb3ec2e89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7b05c10a708cf954f66aa0055eaaa07a4c341ce7d563c9b88f06e4e6b23e1f8eef7308bbd4aea2984bf3ebe1604c3e2c1427c174356dac45305245f1b22ab68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d786b6a7764e77de5b676f4366eab749a81dd8ad568c7f25c0c300a2a848a4368444ec8a1010f8aca99469c7e68538754c159638a363d74151367f6014bb4321"} build_url:https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f63bb99be423b00501c7db110e89cd041d3195395739c683ce08f4a1e855a5004edc1253486b21467dc7dacf3069136f30dc58e2f3a69a54a37b4c7bb3ec2e89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7b05c10a708cf954f66aa0055eaaa07a4c341ce7d563c9b88f06e4e6b23e1f8eef7308bbd4aea2984bf3ebe1604c3e2c1427c174356dac45305245f1b22ab68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d786b6a7764e77de5b676f4366eab749a81dd8ad568c7f25c0c300a2a848a4368444ec8a1010f8aca99469c7e68538754c159638a363d74151367f6014bb4321"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 07:20:54.396252) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 07:20:54.396715) ========= 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.7C6mgvm5gv/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.SEFcX5zgx3/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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.005208 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 07:20:54.446598) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 07:20:54.447054) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 07:20:54.447505) ========= ========= Total master_lag: 0.19 =========