builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0019 starttime: 1477130501.49 results: success (0) buildid: 20161022004018 builduid: 804c17c4729145f5a3c0fcde7068ed33 revision: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:41.490764) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:41.491203) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:41.491542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:41.659839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:41.660166) ========= 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.Qx57OnpfSx/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.br8cRswXy4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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-22 03:01:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 176M=0s 2016-10-22 03:01:41 (176 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177246 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:41.891129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:41.891459) ========= 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.Qx57OnpfSx/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.br8cRswXy4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.028337 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:41.947480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 03:01:41.947812) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 --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 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qx57OnpfSx/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.br8cRswXy4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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-22 03:01:42,021 truncating revision to first 12 chars 2016-10-22 03:01:42,021 Setting DEBUG logging. 2016-10-22 03:01:42,022 attempt 1/10 2016-10-22 03:01:42,022 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/96ca0ecdcfa7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-22 03:01:43,640 unpacking tar archive at: mozilla-aurora-96ca0ecdcfa7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.893873 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 03:01:43.863539) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:43.863849) ========= script_repo_revision: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:43.864240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:43.864510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 03:01:43.882378) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-10-22 03:01:43.882735) ========= /tools/buildbot/bin/python -u 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', '-u', '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.Qx57OnpfSx/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.br8cRswXy4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 03:01:44 INFO - MultiFileLogger online at 20161022 03:01:44 in /builds/slave/test 03:01:44 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 03:01:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:01:44 INFO - {'append_to_log': False, 03:01:44 INFO - 'base_work_dir': '/builds/slave/test', 03:01:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:01:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:01:44 INFO - 'branch': 'Mozilla-Aurora', 03:01:44 INFO - 'buildbot_json_path': 'buildprops.json', 03:01:44 INFO - 'config_files': ('talos/mac_config.py',), 03:01:44 INFO - 'default_actions': ('clobber', 03:01:44 INFO - 'read-buildbot-config', 03:01:44 INFO - 'download-and-extract', 03:01:44 INFO - 'populate-webroot', 03:01:44 INFO - 'create-virtualenv', 03:01:44 INFO - 'install', 03:01:44 INFO - 'run-tests'), 03:01:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:01:44 INFO - 'download_minidump_stackwalk': True, 03:01:44 INFO - 'download_symbols': 'ondemand', 03:01:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:01:44 INFO - 'tooltool.py': '/tools/tooltool.py', 03:01:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:01:44 INFO - '/tools/misc-python/virtualenv.py')}, 03:01:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:01:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:01:44 INFO - 'installer_path': 'installer.exe', 03:01:44 INFO - 'log_level': 'info', 03:01:44 INFO - 'log_name': 'talos', 03:01:44 INFO - 'log_to_console': True, 03:01:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:01:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:01:44 INFO - 'opt_config_files': (), 03:01:44 INFO - 'pip_index': False, 03:01:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:01:44 INFO - 'cmd': ('bash', 03:01:44 INFO - '-c', 03:01:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:01:44 INFO - 'enabled': True, 03:01:44 INFO - 'halt_on_failure': False, 03:01:44 INFO - 'name': 'check_screen_resolution'},), 03:01:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:01:44 INFO - 'cmd': ('bash', 03:01:44 INFO - '-c', 03:01:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:01:44 INFO - 'enabled': True, 03:01:44 INFO - 'halt_on_failure': False, 03:01:44 INFO - 'name': 'check_screen_resolution'},), 03:01:44 INFO - 'run_cmd_checks_enabled': True, 03:01:44 INFO - 'sps_profile': False, 03:01:44 INFO - 'sps_profile_interval': 0, 03:01:44 INFO - 'suite': 'dromaeojs-e10s', 03:01:44 INFO - 'system_bits': '32', 03:01:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:01:44 INFO - 'title': 't-yosemite-r7-0019', 03:01:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:01:44 INFO - 'use_talos_json': True, 03:01:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:01:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:01:44 INFO - 'work_dir': 'build'} 03:01:44 INFO - [mozharness: 2016-10-22 10:01:44.082780Z] Running clobber step. 03:01:44 INFO - Running pre-action listener: _resource_record_pre_action 03:01:44 INFO - Running main action method: clobber 03:01:44 INFO - rmtree: /builds/slave/test/build 03:01:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:01:46 INFO - Running post-action listener: _resource_record_post_action 03:01:46 INFO - [mozharness: 2016-10-22 10:01:46.314790Z] Finished clobber step (success) 03:01:46 INFO - [mozharness: 2016-10-22 10:01:46.314927Z] Running read-buildbot-config step. 03:01:46 INFO - Running pre-action listener: _resource_record_pre_action 03:01:46 INFO - Running main action method: read_buildbot_config 03:01:46 INFO - Using buildbot properties: 03:01:46 INFO - { 03:01:46 INFO - "project": "", 03:01:46 INFO - "product": "firefox", 03:01:46 INFO - "script_repo_revision": "production", 03:01:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:01:46 INFO - "repository": "", 03:01:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:01:46 INFO - "buildid": "20161022004018", 03:01:46 INFO - "stage_platform": "macosx64", 03:01:46 INFO - "basedir": "/builds/slave/test", 03:01:46 INFO - "nightly_build": "True", 03:01:46 INFO - "buildnumber": 11, 03:01:46 INFO - "slavename": "t-yosemite-r7-0019", 03:01:46 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:01:46 INFO - "platform": "yosemite_r7", 03:01:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:01:46 INFO - "branch": "mozilla-aurora", 03:01:46 INFO - "repo_path": "releases/mozilla-aurora", 03:01:46 INFO - "revision": "96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79", 03:01:46 INFO - "pgo_build": "False", 03:01:46 INFO - "builduid": "804c17c4729145f5a3c0fcde7068ed33", 03:01:46 INFO - "slavebuilddir": "test" 03:01:46 INFO - } 03:01:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:01:46 INFO - Running post-action listener: _resource_record_post_action 03:01:46 INFO - [mozharness: 2016-10-22 10:01:46.318325Z] Finished read-buildbot-config step (success) 03:01:46 INFO - [mozharness: 2016-10-22 10:01:46.318458Z] Running download-and-extract step. 03:01:46 INFO - Running pre-action listener: _resource_record_pre_action 03:01:46 INFO - Running main action method: download_and_extract 03:01:46 INFO - mkdir: /builds/slave/test/build/tests 03:01:46 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')]} 03:01:46 INFO - trying https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:01:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/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 03:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/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 03:01:47 INFO - Downloaded 1199 bytes. 03:01:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:01:47 INFO - Using the following test package requirements: 03:01:47 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:01:47 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:01:47 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:01:47 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:01:47 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:01:47 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:01:47 INFO - u'jsshell-mac.zip'], 03:01:47 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:01:47 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:01:47 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:01:47 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:01:47 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:01:47 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:01:47 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:01:47 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:01:47 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:01:47 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:01:47 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:01:47 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:01:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:01:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:01:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:01:48 INFO - Expected file size: 16436648 03:01:55 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 03:01:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:01:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:01:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:01:55 INFO - Expected file size: 16436648 03:02:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:02:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:02:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:02:03 INFO - Expected file size: 14414081 03:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:04 INFO - trying https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:02:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/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 03:02:07 INFO - Downloaded 115562896 bytes. 03:02:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:02:07 INFO - mkdir: /builds/slave/test/properties 03:02:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:02:07 INFO - Writing to file /builds/slave/test/properties/build_url 03:02:07 INFO - Contents: 03:02:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:02:07 INFO - Running post-action listener: _resource_record_post_action 03:02:07 INFO - Running post-action listener: set_extra_try_arguments 03:02:07 INFO - [mozharness: 2016-10-22 10:02:07.865951Z] Finished download-and-extract step (success) 03:02:07 INFO - [mozharness: 2016-10-22 10:02:07.866103Z] Running populate-webroot step. 03:02:07 INFO - Running pre-action listener: _resource_record_pre_action 03:02:07 INFO - Running main action method: populate_webroot 03:02:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:02:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:02:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:02:07 INFO - '--tppagecycles', 03:02:07 INFO - '7'], 03:02:07 INFO - 'tests': ['tsvgm']}}, 03:02:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:02:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:02:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:02:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:02:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:02:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:02:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:07 INFO - 'talos_options': ['--disable-e10s'], 03:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:02:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:02:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:07 INFO - 'talos_options': ['--disable-e10s'], 03:02:07 INFO - 'tests': ['damp', 'tps']}, 03:02:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:07 INFO - 'tests': ['damp', 'tps']}, 03:02:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:02:07 INFO - 'tests': ['dromaeo_dom']}, 03:02:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:02:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:02:07 INFO - 'tests': ['basic_compositor_video']}, 03:02:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:02:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:02:07 INFO - 'tests': ['a11yr', 03:02:07 INFO - 'ts_paint', 03:02:07 INFO - 'tpaint', 03:02:07 INFO - 'sessionrestore', 03:02:07 INFO - 'sessionrestore_no_auto_restore', 03:02:07 INFO - 'tabpaint']}, 03:02:07 INFO - 'other-e10s': {'tests': ['a11yr', 03:02:07 INFO - 'ts_paint', 03:02:07 INFO - 'tpaint', 03:02:07 INFO - 'sessionrestore', 03:02:07 INFO - 'sessionrestore_no_auto_restore', 03:02:07 INFO - 'tabpaint']}, 03:02:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:02:07 INFO - 'ts_paint', 03:02:07 INFO - 'tpaint', 03:02:07 INFO - 'sessionrestore', 03:02:07 INFO - 'sessionrestore_no_auto_restore', 03:02:07 INFO - 'tabpaint']}, 03:02:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:02:07 INFO - 'ts_paint', 03:02:07 INFO - 'tpaint', 03:02:07 INFO - 'sessionrestore', 03:02:07 INFO - 'sessionrestore_no_auto_restore', 03:02:07 INFO - 'tabpaint']}, 03:02:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:02:07 INFO - 'tests': ['a11yr', 03:02:07 INFO - 'ts_paint', 03:02:07 INFO - 'tpaint', 03:02:07 INFO - 'sessionrestore', 03:02:07 INFO - 'sessionrestore_no_auto_restore', 03:02:07 INFO - 'tabpaint']}, 03:02:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:02:07 INFO - 'tests': ['a11yr', 03:02:07 INFO - 'ts_paint', 03:02:07 INFO - 'tpaint', 03:02:07 INFO - 'sessionrestore', 03:02:07 INFO - 'sessionrestore_no_auto_restore', 03:02:07 INFO - 'tabpaint']}, 03:02:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:02:07 INFO - 'tests': ['tsvgx', 03:02:07 INFO - 'tsvgr_opacity', 03:02:07 INFO - 'tart', 03:02:07 INFO - 'tscrollx', 03:02:07 INFO - 'cart']}, 03:02:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:02:07 INFO - 'tsvgr_opacity', 03:02:07 INFO - 'tart', 03:02:07 INFO - 'tscrollx', 03:02:07 INFO - 'cart']}, 03:02:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:07 INFO - 'talos_options': ['--disable-e10s'], 03:02:07 INFO - 'tests': ['tp5o']}, 03:02:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:07 INFO - 'tests': ['tp5o']}, 03:02:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:07 INFO - 'talos_options': ['--disable-e10s', 03:02:07 INFO - '--xperf_path', 03:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:02:07 INFO - 'tests': ['tp5n']}, 03:02:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:02:07 INFO - 'talos_options': ['--xperf_path', 03:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:02:07 INFO - 'tests': ['tp5n']}}, 03:02:07 INFO - 'talos.zip': {'path': '', 03:02:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:02:07 INFO - Running post-action listener: _resource_record_post_action 03:02:07 INFO - [mozharness: 2016-10-22 10:02:07.884925Z] Finished populate-webroot step (success) 03:02:07 INFO - [mozharness: 2016-10-22 10:02:07.885058Z] Running create-virtualenv step. 03:02:07 INFO - Running pre-action listener: _resource_record_pre_action 03:02:07 INFO - Running main action method: create_virtualenv 03:02:07 INFO - Creating virtualenv /builds/slave/test/build/venv 03:02:07 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 03:02:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:02:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:02:08 INFO - Using real prefix '/tools/python27' 03:02:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:02:08 INFO - Installing distribute.............................................................................................................................................................................................done. 03:02:11 INFO - Installing pip.................done. 03:02:11 INFO - Return code: 0 03:02:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104418570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff479d851c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042b6d30>, '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 0x10411cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042aeb20>, '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.Qx57OnpfSx/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.br8cRswXy4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 03:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:02:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qx57OnpfSx/Render', 03:02:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:11 INFO - 'HOME': '/Users/cltbld', 03:02:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PAGER': '/bin/cat', 03:02:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.br8cRswXy4/Listeners', 03:02:11 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 03:02:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - 'XPC_FLAGS': '0x0', 03:02:11 INFO - 'XPC_SERVICE_NAME': '0', 03:02:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:11 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 03:02:11 INFO - Cleaning up... 03:02:11 INFO - Return code: 0 03:02:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1044a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104418570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff479d851c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042b6d30>, '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 0x10411cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042aeb20>, '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.Qx57OnpfSx/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.br8cRswXy4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 03:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:02:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qx57OnpfSx/Render', 03:02:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:11 INFO - 'HOME': '/Users/cltbld', 03:02:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PAGER': '/bin/cat', 03:02:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.br8cRswXy4/Listeners', 03:02:11 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 03:02:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - 'XPC_FLAGS': '0x0', 03:02:11 INFO - 'XPC_SERVICE_NAME': '0', 03:02:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:12 INFO - Downloading/unpacking psutil>=3.1.1 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:02:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:15 INFO - Installing collected packages: psutil 03:02:15 INFO - Running setup.py install for psutil 03:02:15 INFO - building 'psutil._psutil_osx' extension 03:02:15 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 03:02:16 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 03:02:16 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 03:02:16 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 03:02:16 INFO - building 'psutil._psutil_posix' extension 03:02:16 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 03:02:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:02:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:02:16 INFO - ^ 03:02:16 INFO - 1 warning generated. 03:02:16 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 03:02:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:16 INFO - Successfully installed psutil 03:02:16 INFO - Cleaning up... 03:02:16 INFO - Return code: 0 03:02:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:16 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 0x1044a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104418570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff479d851c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042b6d30>, '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 0x10411cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042aeb20>, '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.Qx57OnpfSx/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.br8cRswXy4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 03:02:16 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 03:02:16 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 03:02:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qx57OnpfSx/Render', 03:02:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:16 INFO - 'HOME': '/Users/cltbld', 03:02:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:16 INFO - 'LOGNAME': 'cltbld', 03:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:16 INFO - 'MOZ_NO_REMOTE': '1', 03:02:16 INFO - 'NO_EM_RESTART': '1', 03:02:16 INFO - 'PAGER': '/bin/cat', 03:02:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:16 INFO - 'PWD': '/builds/slave/test', 03:02:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:16 INFO - 'SHELL': '/bin/bash', 03:02:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.br8cRswXy4/Listeners', 03:02:16 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 03:02:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:16 INFO - 'USER': 'cltbld', 03:02:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:16 INFO - 'XPC_FLAGS': '0x0', 03:02:16 INFO - 'XPC_SERVICE_NAME': '0', 03:02:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:02:19 INFO - Installing collected packages: mozsystemmonitor 03:02:19 INFO - Running setup.py install for mozsystemmonitor 03:02:19 INFO - Successfully installed mozsystemmonitor 03:02:19 INFO - Cleaning up... 03:02:19 INFO - Return code: 0 03:02:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:02:19 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')]} 03:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:19 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')]} 03:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:19 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 0x1044a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104418570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff479d851c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042b6d30>, '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 0x10411cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042aeb20>, '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.Qx57OnpfSx/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.br8cRswXy4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 03:02:19 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 03:02:19 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 03:02:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qx57OnpfSx/Render', 03:02:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:19 INFO - 'HOME': '/Users/cltbld', 03:02:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:19 INFO - 'LOGNAME': 'cltbld', 03:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:19 INFO - 'MOZ_NO_REMOTE': '1', 03:02:19 INFO - 'NO_EM_RESTART': '1', 03:02:19 INFO - 'PAGER': '/bin/cat', 03:02:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:19 INFO - 'PWD': '/builds/slave/test', 03:02:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:19 INFO - 'SHELL': '/bin/bash', 03:02:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.br8cRswXy4/Listeners', 03:02:19 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 03:02:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:19 INFO - 'USER': 'cltbld', 03:02:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:19 INFO - 'XPC_FLAGS': '0x0', 03:02:19 INFO - 'XPC_SERVICE_NAME': '0', 03:02:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:20 INFO - Downloading/unpacking jsonschema==2.5.1 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:02:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:02:22 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 03:02:22 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 03:02:22 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 03:02:22 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 03:02:22 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 03:02:22 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 03:02:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:02:22 INFO - warning: no files found matching '*.txt' 03:02:22 INFO - no previously-included directories found matching 'build' 03:02:22 INFO - no previously-included directories found matching 'dist' 03:02:22 INFO - no previously-included directories found matching '.git*' 03:02:23 INFO - Installing collected packages: jsonschema, functools32 03:02:23 INFO - Running setup.py install for functools32 03:02:23 INFO - warning: no files found matching '*.txt' 03:02:23 INFO - no previously-included directories found matching 'build' 03:02:23 INFO - no previously-included directories found matching 'dist' 03:02:23 INFO - no previously-included directories found matching '.git*' 03:02:23 INFO - Successfully installed jsonschema functools32 03:02:23 INFO - Cleaning up... 03:02:23 INFO - Return code: 0 03:02:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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', '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 0x1044a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104418570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff479d851c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042b6d30>, '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 0x10411cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042aeb20>, '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.Qx57OnpfSx/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.br8cRswXy4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 03:02: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:02: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 functools32==3.2.3-2 03:02:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qx57OnpfSx/Render', 03:02:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:23 INFO - 'HOME': '/Users/cltbld', 03:02:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:23 INFO - 'LOGNAME': 'cltbld', 03:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:23 INFO - 'MOZ_NO_REMOTE': '1', 03:02:23 INFO - 'NO_EM_RESTART': '1', 03:02:23 INFO - 'PAGER': '/bin/cat', 03:02:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:23 INFO - 'PWD': '/builds/slave/test', 03:02:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:23 INFO - 'SHELL': '/bin/bash', 03:02:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.br8cRswXy4/Listeners', 03:02:23 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 03:02:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:23 INFO - 'USER': 'cltbld', 03:02:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:23 INFO - 'XPC_FLAGS': '0x0', 03:02:23 INFO - 'XPC_SERVICE_NAME': '0', 03:02:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:02:23 INFO - Cleaning up... 03:02:23 INFO - Return code: 0 03:02:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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', '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 0x1044a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104418570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff479d851c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042b6d30>, '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 0x10411cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042aeb20>, '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.Qx57OnpfSx/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.br8cRswXy4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 03:02: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:02: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 blobuploader==1.2.4 03:02:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qx57OnpfSx/Render', 03:02:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:23 INFO - 'HOME': '/Users/cltbld', 03:02:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:23 INFO - 'LOGNAME': 'cltbld', 03:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:23 INFO - 'MOZ_NO_REMOTE': '1', 03:02:23 INFO - 'NO_EM_RESTART': '1', 03:02:23 INFO - 'PAGER': '/bin/cat', 03:02:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:23 INFO - 'PWD': '/builds/slave/test', 03:02:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:23 INFO - 'SHELL': '/bin/bash', 03:02:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.br8cRswXy4/Listeners', 03:02:23 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 03:02:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:23 INFO - 'USER': 'cltbld', 03:02:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:23 INFO - 'XPC_FLAGS': '0x0', 03:02:23 INFO - 'XPC_SERVICE_NAME': '0', 03:02:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:02:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:02:26 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 03:02:26 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 03:02:26 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 03:02:26 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 03:02:26 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 03:02:26 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 03:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:02:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:27 INFO - Downloading docopt-0.6.1.tar.gz 03:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:02:27 INFO - Installing collected packages: blobuploader, requests, docopt 03:02:27 INFO - Running setup.py install for blobuploader 03:02:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:02:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:02:27 INFO - Running setup.py install for requests 03:02:28 INFO - Running setup.py install for docopt 03:02:28 INFO - Successfully installed blobuploader requests docopt 03:02:28 INFO - Cleaning up... 03:02:28 INFO - Return code: 0 03:02:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:28 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 0x1044a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104418570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff479d851c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042b6d30>, '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 0x10411cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042aeb20>, '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.Qx57OnpfSx/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.br8cRswXy4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 03:02:28 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 03:02:28 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 03:02:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qx57OnpfSx/Render', 03:02:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:28 INFO - 'HOME': '/Users/cltbld', 03:02:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:28 INFO - 'LOGNAME': 'cltbld', 03:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:28 INFO - 'MOZ_NO_REMOTE': '1', 03:02:28 INFO - 'NO_EM_RESTART': '1', 03:02:28 INFO - 'PAGER': '/bin/cat', 03:02:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:28 INFO - 'PWD': '/builds/slave/test', 03:02:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:28 INFO - 'SHELL': '/bin/bash', 03:02:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.br8cRswXy4/Listeners', 03:02:28 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 03:02:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:28 INFO - 'USER': 'cltbld', 03:02:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:28 INFO - 'XPC_FLAGS': '0x0', 03:02:28 INFO - 'XPC_SERVICE_NAME': '0', 03:02:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:28 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-KsxEqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:28 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-SGMm1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:28 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-VNpLEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:29 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-x1H0LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:29 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-mLgV2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:29 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-a7cTII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:29 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-Rfca5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:29 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-Bl50NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:29 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-6sGYBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:29 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-8bOPAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:29 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-ZTH5DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:29 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-6WJtLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:29 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-vzu8A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:30 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-d4ypXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:30 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-d8qkNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:30 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-vKD5fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:30 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-OuFeh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:02:30 INFO - Running setup.py install for manifestparser 03:02:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:02:30 INFO - Running setup.py install for mozcrash 03:02:30 INFO - Running setup.py install for mozdebug 03:02:30 INFO - Running setup.py install for mozdevice 03:02:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:02:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:02:31 INFO - Running setup.py install for mozfile 03:02:31 INFO - Running setup.py install for mozhttpd 03:02:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:02:31 INFO - Running setup.py install for mozinfo 03:02:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:02:31 INFO - Running setup.py install for mozInstall 03:02:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:02:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:02:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:02:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:02:31 INFO - Running setup.py install for mozleak 03:02:31 INFO - Running setup.py install for mozlog 03:02:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:02:32 INFO - Running setup.py install for moznetwork 03:02:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:02:32 INFO - Running setup.py install for mozprocess 03:02:32 INFO - Running setup.py install for mozprofile 03:02:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:02:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:02:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:02:32 INFO - Running setup.py install for mozrunner 03:02:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:02:32 INFO - Running setup.py install for mozscreenshot 03:02:32 INFO - Running setup.py install for moztest 03:02:32 INFO - Running setup.py install for mozversion 03:02:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:02:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:02:33 INFO - Cleaning up... 03:02:33 INFO - Return code: 0 03:02:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:33 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')]} 03:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:33 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')]} 03:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:33 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 0x1044a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104418570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff479d851c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042b6d30>, '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 0x10411cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042aeb20>, '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.Qx57OnpfSx/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.br8cRswXy4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 03:02:33 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 03:02:33 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 03:02:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qx57OnpfSx/Render', 03:02:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:33 INFO - 'HOME': '/Users/cltbld', 03:02:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:33 INFO - 'LOGNAME': 'cltbld', 03:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:33 INFO - 'MOZ_NO_REMOTE': '1', 03:02:33 INFO - 'NO_EM_RESTART': '1', 03:02:33 INFO - 'PAGER': '/bin/cat', 03:02:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:33 INFO - 'PWD': '/builds/slave/test', 03:02:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:33 INFO - 'SHELL': '/bin/bash', 03:02:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.br8cRswXy4/Listeners', 03:02:33 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 03:02:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:33 INFO - 'USER': 'cltbld', 03:02:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:33 INFO - 'XPC_FLAGS': '0x0', 03:02:33 INFO - 'XPC_SERVICE_NAME': '0', 03:02:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-dZJZNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:33 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)) 03:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-ahdlFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:33 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)) 03:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-uTPPXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:33 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)) 03:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-TONTvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:33 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)) 03:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-RJhx1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:33 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)) 03:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-CB7gCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:34 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)) 03:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-P3c1mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:34 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)) 03:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-m6dDz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:34 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)) 03:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-ACYSBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:34 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)) 03:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-PfVntl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:34 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)) 03:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-xfDHgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:34 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)) 03:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-gW4A8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:34 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)) 03:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-wLdPHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:34 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)) 03:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-jHohzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:34 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)) 03:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-JA7z8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:35 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)) 03:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-76ayGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:35 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)) 03:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-KZP5qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:35 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)) 03:02:35 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)) 03:02:35 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)) 03:02:35 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)) 03:02:35 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)) 03:02:35 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)) 03:02:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:37 INFO - Downloading blessings-1.6.tar.gz 03:02:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:02:37 INFO - Installing collected packages: blessings 03:02:37 INFO - Running setup.py install for blessings 03:02:37 INFO - Successfully installed blessings 03:02:37 INFO - Cleaning up... 03:02:38 INFO - Return code: 0 03:02:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:38 INFO - Reading from file tmpfile_stdout 03:02:38 INFO - Current package versions: 03:02:38 INFO - blessings == 1.6 03:02:38 INFO - blobuploader == 1.2.4 03:02:38 INFO - docopt == 0.6.1 03:02:38 INFO - functools32 == 3.2.3-2 03:02:38 INFO - jsonschema == 2.5.1 03:02:38 INFO - manifestparser == 1.1 03:02:38 INFO - mozInstall == 1.12 03:02:38 INFO - mozcrash == 0.17 03:02:38 INFO - mozdebug == 0.1 03:02:38 INFO - mozdevice == 0.48 03:02:38 INFO - mozfile == 1.2 03:02:38 INFO - mozhttpd == 0.7 03:02:38 INFO - mozinfo == 0.9 03:02:38 INFO - mozleak == 0.1 03:02:38 INFO - mozlog == 3.4 03:02:38 INFO - moznetwork == 0.27 03:02:38 INFO - mozprocess == 0.23 03:02:38 INFO - mozprofile == 0.28 03:02:38 INFO - mozrunner == 6.12 03:02:38 INFO - mozscreenshot == 0.1 03:02:38 INFO - mozsystemmonitor == 0.3 03:02:38 INFO - moztest == 0.7 03:02:38 INFO - mozversion == 1.4 03:02:38 INFO - psutil == 3.1.1 03:02:38 INFO - requests == 1.2.3 03:02:38 INFO - wsgiref == 0.1.2 03:02:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:38 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 0x1044a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104418570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff479d851c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042b6d30>, '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 0x10411cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042aeb20>, '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.Qx57OnpfSx/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.br8cRswXy4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 03:02:38 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 03:02:38 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 03:02:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qx57OnpfSx/Render', 03:02:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:38 INFO - 'HOME': '/Users/cltbld', 03:02:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:38 INFO - 'LOGNAME': 'cltbld', 03:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:38 INFO - 'MOZ_NO_REMOTE': '1', 03:02:38 INFO - 'NO_EM_RESTART': '1', 03:02:38 INFO - 'PAGER': '/bin/cat', 03:02:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:38 INFO - 'PWD': '/builds/slave/test', 03:02:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:38 INFO - 'SHELL': '/bin/bash', 03:02:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.br8cRswXy4/Listeners', 03:02:38 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 03:02:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:38 INFO - 'USER': 'cltbld', 03:02:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:38 INFO - 'XPC_FLAGS': '0x0', 03:02:38 INFO - 'XPC_SERVICE_NAME': '0', 03:02:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:38 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)) 03:02:38 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)) 03:02:38 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)) 03:02:38 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)) 03:02:38 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)) 03:02:38 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)) 03:02:38 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)) 03:02:38 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)) 03:02:38 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)) 03:02:38 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)) 03:02:38 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)) 03:02:38 INFO - Cleaning up... 03:02:38 INFO - Return code: 0 03:02:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104418570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff479d851c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042b6d30>, '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 0x10411cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042aeb20>, '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.Qx57OnpfSx/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.br8cRswXy4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 03:02:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:02:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qx57OnpfSx/Render', 03:02:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:38 INFO - 'HOME': '/Users/cltbld', 03:02:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:38 INFO - 'LOGNAME': 'cltbld', 03:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:38 INFO - 'MOZ_NO_REMOTE': '1', 03:02:38 INFO - 'NO_EM_RESTART': '1', 03:02:38 INFO - 'PAGER': '/bin/cat', 03:02:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:38 INFO - 'PWD': '/builds/slave/test', 03:02:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:38 INFO - 'SHELL': '/bin/bash', 03:02:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.br8cRswXy4/Listeners', 03:02:38 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 03:02:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:38 INFO - 'USER': 'cltbld', 03:02:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:38 INFO - 'XPC_FLAGS': '0x0', 03:02:38 INFO - 'XPC_SERVICE_NAME': '0', 03:02:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:02:38 INFO - Cleaning up... 03:02:38 INFO - Return code: 0 03:02:38 INFO - Running post-action listener: _resource_record_post_action 03:02:38 INFO - Running post-action listener: _start_resource_monitoring 03:02:38 INFO - Starting resource monitoring. 03:02:38 INFO - [mozharness: 2016-10-22 10:02:38.863627Z] Finished create-virtualenv step (success) 03:02:38 INFO - [mozharness: 2016-10-22 10:02:38.864596Z] Running install step. 03:02:38 INFO - Running pre-action listener: _resource_record_pre_action 03:02:38 INFO - Running main action method: install 03:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:39 INFO - Reading from file tmpfile_stdout 03:02:39 INFO - Detecting whether we're running mozinstall >=1.0... 03:02:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:02:39 INFO - Reading from file tmpfile_stdout 03:02:39 INFO - Output received: 03:02:39 INFO - Usage: mozinstall [options] installer 03:02:39 INFO - Options: 03:02:39 INFO - -h, --help show this help message and exit 03:02:39 INFO - -d DEST, --destination=DEST 03:02:39 INFO - Directory to install application into. [default: 03:02:39 INFO - "/builds/slave/test"] 03:02:39 INFO - --app=APP Application being installed. [default: firefox] 03:02:39 INFO - mkdir: /builds/slave/test/build/application 03:02:39 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'] 03:02:39 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 03:03:11 INFO - Reading from file tmpfile_stdout 03:03:11 INFO - Output received: 03:03:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:03:11 INFO - Running post-action listener: _resource_record_post_action 03:03:11 INFO - [mozharness: 2016-10-22 10:03:11.364474Z] Finished install step (success) 03:03:11 INFO - [mozharness: 2016-10-22 10:03:11.364609Z] Running run-tests step. 03:03:11 INFO - Running pre-action listener: _resource_record_pre_action 03:03:11 INFO - Running main action method: run_tests 03:03:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:03:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:03:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:03:11 INFO - 2016-10-22 03:03:11.378 screenresolution[1663:17005] starting screenresolution argv=screenresolution get 03:03:11 INFO - 2016-10-22 03:03:11.381 screenresolution[1663:17005] Display 0: 1600x1200x32@60 03:03:11 INFO - 2016-10-22 03:03:11.387 screenresolution[1664:17008] starting screenresolution argv=screenresolution list 03:03:11 INFO - Available Modes on Display 0 03:03:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:03:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:03:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:03:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:03:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:03:11 INFO - Intel Iris: 03:03:11 INFO - Chipset Model: Intel Iris 03:03:11 INFO - Type: GPU 03:03:11 INFO - Bus: Built-In 03:03:11 INFO - VRAM (Dynamic, Max): 1536 MB 03:03:11 INFO - Vendor: Intel (0x8086) 03:03:11 INFO - Device ID: 0x0a2e 03:03:11 INFO - Revision ID: 0x0009 03:03:11 INFO - Displays: 03:03:11 INFO - Display: 03:03:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:03:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:03:11 INFO - Display Serial Number: 1600x1200 60 03:03:11 INFO - Main Display: Yes 03:03:11 INFO - Mirror: Off 03:03:11 INFO - Online: Yes 03:03:11 INFO - Rotation: Supported 03:03:11 INFO - Return code: 0 03:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:03:11 INFO - Python 2.7.3 03:03:11 INFO - Return code: 0 03:03:11 INFO - grabbing minidump binary from tooltool 03:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:11 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 0x1042b6d30>, '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 0x10411cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042aeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:03:11 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 03:03:11 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 03:03:11 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 03:03:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:03:11 INFO - Return code: 0 03:03:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:03:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:03:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:03:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:03:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:03:11 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/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--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 03:03:11 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/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0019 --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 03:03:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qx57OnpfSx/Render', 03:03:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:11 INFO - 'HOME': '/Users/cltbld', 03:03:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:11 INFO - 'LOGNAME': 'cltbld', 03:03:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:03:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:11 INFO - 'MOZ_NO_REMOTE': '1', 03:03:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:03:11 INFO - 'NO_EM_RESTART': '1', 03:03:11 INFO - 'PAGER': '/bin/cat', 03:03:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:11 INFO - 'PWD': '/builds/slave/test', 03:03:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:03:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:11 INFO - 'SHELL': '/bin/bash', 03:03:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.br8cRswXy4/Listeners', 03:03:11 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 03:03:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:11 INFO - 'USER': 'cltbld', 03:03:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:11 INFO - 'XPC_FLAGS': '0x0', 03:03:11 INFO - 'XPC_SERVICE_NAME': '0', 03:03:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:11 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/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--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 03:03:11 INFO - mozversion application_buildid: 20161022004018 03:03:11 INFO - mozversion application_changeset: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 03:03:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:03:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:03:11 INFO - mozversion application_name: Firefox 03:03:11 INFO - mozversion application_remotingname: firefox-dev 03:03:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:03:11 INFO - mozversion application_vendor: Mozilla 03:03:11 INFO - mozversion application_version: 51.0a2 03:03:11 INFO - mozversion platform_buildid: 20161022004018 03:03:11 INFO - mozversion platform_changeset: 96ca0ecdcfa7b14cab40e8c7a0a4d97441652a79 03:03:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:03:11 INFO - mozversion platform_version: 51.0a2 03:03:11 INFO - using testdate: 1477130591 03:03:11 INFO - actual date: 1477130591 03:03:11 INFO - starting webserver on 'localhost:49274' 03:03:11 INFO - SUITE-START | Running 2 tests 03:03:11 INFO - TEST-START | dromaeo_css 03:03:11 INFO - operating with platform_type : mac_ 03:03:11 INFO - Initialising browser for dromaeo_css test... 03:03:12 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpkIFzDF/profile http://localhost:49274/getInfo.html) 03:03:14 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 03:03:14 INFO - PROCESS | 1674 | colorDepth:24 03:03:14 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 03:03:14 INFO - PROCESS | 1674 | __metrics 03:03:14 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:03:15 INFO - TEST-INFO | 1674: exit 0 03:03:15 INFO - Browser initialized. 03:03:15 INFO - Running cycle 1/1 for dromaeo_css test... 03:03:15 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpkIFzDF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:03:27 INFO - PROCESS | 1679 | RSS: Main: 224837632 03:03:27 INFO - PROCESS | 1679 | 03:04:17 INFO - PROCESS | 1679 | 1477130657233 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] 03:06:28 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 03:06:29 INFO - PROCESS | 1679 | RSS: Main: 236994560 03:06:29 INFO - PROCESS | 1679 | 03:09:32 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 03:09:32 INFO - PROCESS | 1679 | RSS: Main: 248578048 03:09:32 INFO - PROCESS | 1679 | 03:12:34 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 03:12:35 INFO - PROCESS | 1679 | RSS: Main: 251129856 03:12:35 INFO - PROCESS | 1679 | 03:15:37 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 03:15:37 INFO - PROCESS | 1679 | RSS: Main: 252465152 03:15:37 INFO - PROCESS | 1679 | 03:18:40 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 03:18:41 INFO - PROCESS | 1679 | RSS: Main: 256806912 03:18:41 INFO - PROCESS | 1679 | 03:21:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 03:21:43 INFO - PROCESS | 1679 | RSS: Main: 258703360 03:21:43 INFO - PROCESS | 1679 | 03:21:43 INFO - PROCESS | 1679 | __start_tp_report 03:21:43 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 03:21:43 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 03:21:43 INFO - PROCESS | 1679 | |i|pagename|runs| 03:21:43 INFO - PROCESS | 1679 | |0;dojo.html;2820.815257591811;2825.350169461024;2873.8850445982157;2918.730352296751;2946.5580162975566;4309.288967320388;5439.238506609078;5599;5644.20981062651;5655.8586035349035;4945.9258111128365;5335.759890804913;5629.268195134637;5630.352509461413;5656.038473459512;5190.896182076356;5221.817236396727;5234.345706786652;5245.4754524547625;5258.894822103555;4386.8025938832825;5175.844724658266;5195.636305458619;5259.289995850569;5317.973410132944;5152.355955505562;5160.535551800356;5231.346081739783;5231.947680523184;5285.154375299952;4315.201687687756;5179.844604661847;5182.093133701606;5256.92114618281;5332.066888294533;5127.769250383742;5198.818041368534;5202.713850738208;5211.088059589557;5227.26818245446;4351.825926962918;4785.545373189541;5491.203775452537;5649.096144616883;5746.942530574683;6054.576179667425;6062.393760623902;6063.818085457443;6086.269647642312;6109.297430795426;6134.907976380313;6164.537659675498;6166.907496387557;6192;6202.906956395657;5716.514096301819;5717.399673034354;5727.968965586235;5732.283464566929;5742.3396309424115;6168.845778855564;6187.597806142587;6207.472364848948;6218.378162183745;6280.528960327993;6096.634201947809;6100.328963813977;6103.298120716086;6113.052476866093;6121.908171377433;6203;6206.224221972254;6232.719527621268;6245.219347581552;6263.561550691408;5946.583739138306;6004.219451471281;6020.127081573148;6082.2701275847185;6101.511879049665;6159.23009623797;6187.474064704461;6198.938010619926;6209.6895155242055;6219.284782250009;4828.95171048285;4870.9269360959615;4879.926416188433;4884.3650325457465;4894.510548945077;4251.829926802893;4284.400183974246;4330.501992270929;4388.868333949987;4392.472903251631;5703.344115426696;5800.59395842287;5842.474177324061;5842.59101862874;5842.737076831553;5653.293338332708;6246.625202487865;6247.437730604177;6259.71831267594;6290.150829638032;5603;5701.344345400332;5726.885462290814;5777.913331300034;5794.1308803679785;5328.120860058125;5342.492463215988;5362.892742145135;5366.060939335601;5366.597505187126;6278.843028924222;6288.151099601587;6289.7169627366875;6290.842728931813;6297.055441683784;6042.788502402394;6071.726772295169;6135.478484328882;6136.723847426787;6238.126662267377;5227.032998895216;6261.123442718114;6266.811995640138;6275.497960163268;6284.151639528788;6069.180660610761;6095.847603809941;6109.358517355614;6113.663748493876;6123.418275263843;6098.9390106100145;6125.143885071339;6186.907196391968;6194.628322300677;6219.129321895029;4355.499117601516;5950.464458198783;6075.817725468243;6090.847728806815;6126;4977.925331119964;5866.7066646668345;6038.064100064497;6041.516678665608;6065.3934606539;4536.591706746409;5846.035404158266;5890.970545147418;5935.881282374415;5958.19564358806;5819.0689489681445;5878.764849405976;5971;5999.250093738283;6000.549958753199;4804.783784729765;5876.030454974882;5878.412158784087;5897.823065308047;5919.644821310735 03:21:43 INFO - PROCESS | 1679 | |1;ext.html;466.92529195328757;483.2557860894222;501.6839391183554;525.8764190415252;528.4636094364218;39229.41155882661;41078.973025674335;41132.588674113285;43828.78085609576;43901.78049109758;42842.57157428425;42927.14145717092;43326.56673433265;43410.7829460853;43433.56566434335;9732.999999999982;9915.058069483424;9926.503674816266;9927.305088643798;9939.453330066843;9728.951355243214;9793.657221997231;9809.21526277896;9829.115379615832;9829.901700983006;9752.36609620376;9772.706818795448;9786.119249267564;9797.412155270707;9815;8731.869021964676;9540.855097388358;9784.315097943147;9784.510774461283;9820.36167649104;9771.560279787427;9844.507774611313;9857.408555486694;9858.507074646239;9859.457729824857;40637.79681101605;40828.59171408307;40890.159942802646;41014.1797164058;41099.589004109876;3249.382617302705;3612.1330880588735;3612.71098312137;3842.212346468967;3850.614938506127;29475.852620736972;30789.69210307913;31533.211669708213;31736;32011.51982720261;3199;3238.3199528098894;3249.382617302705;3312.403767321881;3440.139965008748;498037.9999999964;502199;504728;505181;507067;59442.10836837451;59541;59739.402605974254;59768;59932;34038.31923361519;34468.96593102211;34828.82585587056;36368.81815590905;61458.38541614527;14761.188134652697;17299.875508092184;17310.307587696603;17320.480385588453;17325.65348693019;12441.75116497665;12875.484980600671;13132.868671313356;13231.603051908458;13238.338083095807;19188.424347269603;19217.231310747695;19322.613547728968;19404.611907761766;19413.223471061;6796.93203067963;7101;7674.963879876145;7986.880196797053;7998.040724931812;883.4831623500196;968.4867020479016;969.7199696400684;1007.6473234367912;1052.2160990062453;28923.42153156925;29072.563911541343;29234.7076529232;29406.26484337866;30893.06668664029;917.9816403671889;1013.4679293371039;1060.1412855587;1061.4639606998417;1068.5458680060942;13528.932355338357;13593.456261749618;13629.647378299596;14359.712805743826;16739.246733897005;510541;655774;662455;671177;671398;57303.42696573064;57717.71141144352;58309.41690583125;58407.70796146077;59100.40899591035;1366.2485632901864;1376.504458394977;1389.7290028444356;1395.8255218097738;1401.7546929287537;28551.714482854906;29162.854185728935;30379;30470;31234.375312494078;46278.537214627424;48708.756456217496;50395.49604504055;50441.49558504368;50623.74688126536;530562;531501;531761;535525;631095;25281.367965801;25877.223683289532;26177.95288188451;26203.213903582924;26318.86840565785;45568.772156139006;45702.54297457116;45769.54230457653;46607.53392466032;46714.29928551142;37875.86372408832;38355.232895342495;38614.4207836877;39069;39661.80169099136;38655.42016869693;38906;39468.80265598654;39573.80213098916;39693.60306397015;35780.82109589539;36059.45910811392;36199.45700814542;36620.81689591535;36853.44719829258;32755;33654.495182571794;34116.829415853754;34587.48118778271;34689.1327716799;19300.8069919299;25230;25399.238022859343;25643.743562564134;26077 03:21:43 INFO - PROCESS | 1679 | |2;jquery.html;307.65081632347284;307.66310889575914;362.6591004455813;379.9418619145678;382.77416324368653;19734.90132549337;19953.501162470944;20241.886696231737;20563.691544626843;20855.0615222315;16478.505644830646;17381.044042577683;19769.209231630717;19958.101885415155;20295.391138265837;5301.628885977983;5705.201271821938;5797.5795929997;5954.732037058343;5978.611390259619;5743.224664670279;6086.634801911878;6133.877322453548;6191.288001879797;6199;5940.435658612425;6114.8777024459705;6183.072539119124;6184.938150618481;6191.226096737908;6178.135061091451;6208.75164993402;6209.472194863442;6214.440700336946;6246.875062498747;5769.682667453289;5998.490128339096;6003.369646187175;6047.21386219793;6068.453839154453;12814.871851281461;12997.15518491295;13098.34508274592;18798.906005469886;25295.36761580957;2333.1367394064305;2419.987900060506;2856.9142925712263;3005.6393232811984;3039.149038269288;9856.50717464131;10072.647457339031;10221;12137.453814578364;15708.507691769379;1679.9580010499712;1824.8229891719766;1918.5299601597558;1938.176275083084;1939.4375631066973;130984.345078274;132124;135157;135193;137331.31334343363;9971.501424928725;11438.256513326607;11676.883231167749;11765.882241187073;11799.88200118005;14499.202543859978;14602.707945841024;14623.78064329036;14648.780268295985;14660.633484162981;8601.827963440695;8619.094995025558;8688.304935605136;8705.823544113971;8716.259117974916;7839.804004899923;8218.301444377295;8695.826083478421;8794.42836215644;9003.279737620975;4487;4491.618212451978;4514.029483661028;4525.479569849509;4552.931706024412;1682.6971145193738;1915.0466524145572;1915.52111972007;1937.321937321926;1972.2447022150297;829.3986859526915;893;908.3868388837508;928.763165392834;963.5182408795603;20542.17831286732;21316.680249796267;21341.893290533757;21506.784932150476;21580.352589422342;901.8286525560122;925.5233554719325;928.1228192603012;974.3277138774223;978.4178413843894;8415.895916270032;10772.030517253485;10917.126629869592;11085.168612354106;11097.834727353511;581217;608135;609685;622570;623207;91538;117074.41462792802;117268.41365793116;134422;141214;954.656323723459;960.078324808178;975.4244995452575;985.0592683986775;985.640241311916;15748;18634.813651863307;18857;19384.2246310146;19451.51371215731;34217;49993;51054.48945510497;52656;54519.18221226764;58816;72302;75157;80060;83858;7148.606826624586;8205.507669539847;8210.261076503144;8298.045724741733;8344.998600168019;11059.336439813636;13024.218546887218;13135;13238.4042718076;13560.38978246001;5199.792008319625;5415.729213539228;11262.817404172773;11352.777722247529;11439.313641181223;10964.671059868217;11328.773424531628;11455.140864435367;11577.6526704199;11661.76676466483;11384.316940983568;11614.825777613174;11680.299182049104;11777.822217778154;11987.700307492034;8058;8101.270885620323;8322.875156872531;8336.541490218096;8495.065542790164;9895.455749933823;11415.714607134889;11703.882961170279;11779;11909.940450297692 03:21:43 INFO - PROCESS | 1679 | |3;mootools.html;1362.1758835904277;1530.53318737785;1740;1851.5093500222436;1908.4751693284336;8085.191480851912;8335.249827515523;8508.95745521273;9065.546722663865;9091.136342047512;7894.842103157934;8816.471011739284;8833.293336533077;8904.95547522263;8917.10828917108;2360.280114565057;2389.808815294772;2391.151141344824;2394.0064873077654;2404.843685160468;2364.337985364101;2369.644553316999;2403.3270684208364;2405.2663937499055;2413.2880800163907;2153.7630860605323;2300.309907027885;2390.4501964548163;2407.6027455469825;2411.505641343529;2371.1108334374608;2386.307970688507;2390.569697454449;2396.6698482342294;2398.436367453647;2377.393764590036;2391.8206134539805;2392.485615592656;2396.2930935373934;2396.6884305040408;8892.066333035003;8938.687145949925;9008.684696035672;9028.368014239006;9037.367384283103;5275.525202731773;5440.809571664972;5444.40111587725;5455.5908306876745;5458.4814442627885;3604.819759012039;3645.3620616392027;3648.252108317815;3716.2753263113705;3717.9814100929593;1082.7401423658266;1096.950637221327;1098.0885864732254;1100.5762781329165;1107.03687791621;11046.723831904266;11819.290842549475;11872.40637968098;11881.94059029708;11883.465244064038;4601.838935637304;4679.976600117046;4838.830640927551;4861.927071093936;4861.978984413242;10026.09765121128;10062.597496100221;10086.092251697382;10093.394396336244;10104.494775261208;5332.653377530526;5419.458054194628;5426.104692725656;5428.91856622143;5450.809221677222;3967.563568007517;4407.206702793464;4412.830599891032;4426.092651006536;4580.7938642761155;3969.54350249725;4006.1787333596544;4055.8174882130374;4096.303628383182;4121.855735049319;1290.7418516296777;1297.202220634303;1302.0560093931824;1308.149702693238;1315.3094625321783;852.9616167272487;927.8144371125667;932.5150921520772;936.166811537732;946.7491114854569;6002.849928751729;6015.849603759853;6046.183765191643;6079.726412311456;6119.326874043941;443.9289713645801;455.27838376174134;458.02212276789294;460.07065727231475;463.3536216977298;4009.3184158693093;4026.798660066985;4040.373742069984;4052.756834589934;4086.6322031016757;10179.898201018043;10722.41026743521;10761.085307748928;10883.292585981886;10919.672409827717;10006.69979900604;10821.729456763644;10825.458727063615;10841.891581084088;10845.403502807263;7953.12515623281;8339.291160251447;8366.874496882552;8369.707060252862;8379.70671026511;5529.253550770594;5589.217509548747;5705.543556515552;5743.885122297447;5790.536757059509;9823.968483309149;10099.7475063124;10196.235282353704;10199.0820826126;10209.74475638115;9971.800563988825;10275.640352587623;10285.43430111351;10375.94812025935;10465.267431279737;5634.915476267941;7217.7473788417155;7402.851942961218;7484.288992545699;7593.848123037619;8404.20160084791;8466.449680770731;8509.574521274035;8514.74455766328;8582.65669373218;7394.260573942563;7471.140818805907;7636;7672.5012874163;7715.729949451742;7238.27617238293;7455.217202193691;7456.4034877208605;7501.699932002659;7660.80847978805;6698.56459330142;7065.399441047363;7110.964445177741;7144.428445724434;7158.928410716035;4907.533784290486;5012.097822392005;5015.423226328873;5028.069807085701;5147.948520514747;5057.013882293065;5075.77159027852;5146.408163061146;5173.301604283524;5198 03:21:43 INFO - PROCESS | 1679 | |4;prototype.html;298.351086387108;300.2598594464644;307.1216321321022;310.4412058295068;312.5015600117811;5149.150390185615;5319.973400133003;5332.440093790149;5390.973045134774;5496.862578435536;3914.725969182158;4527.954720452794;4718.183499352756;5005.249212618109;5333.893322133565;3361.2941282330617;3516.402211624017;4078;4088.5093788745394;4115.403266526352;3371.0898057524455;3830.8276127574327;4059.391091336294;4096.057906681465;4106.404571337169;3269.6566860479666;3537.982310088446;3997.6801855851463;4022.979885100585;4042.73722208057;2988.1035689293126;3780.262848744496;3888.863889763845;4008.33862412703;4045.4538637283886;3331.4503106987318;3491.022513696144;3505.929881402383;3509.6665816747623;3578.9284214315567;3891.571927088018;4936.80252789888;5120.820771273025;5125.591481664688;5131.486851314876;4567.771611419415;4568.314752787075;4570.720198344469;4581.151832460716;4624.606908412756;4593.770311484446;5340.519353258225;5583.3858275589655;5611.859703507404;5650.51970582501;3339.397089397103;3710.6474884885893;3760.126457221904;3841.961580384216;3847.769133851978;5190.377154741455;5778.27771528559;5925.229720136354;5961.254843144607;5961.761529538813;3874.2251549690177;3897.6881849451975;3905.5703872573995;3910.648041676263;3916.6083391660604;3354.681305275995;3553.857845686195;3725.535252215466;3969.3649016157856;3969.7419667721506;3771.830267637963;4444.8444304449185;4543.65922555803;4565.876867256675;4569.1547063793305;4730.432348118179;5675.716214189274;5686.772529098873;5705.971470142706;5719.799807006735;1227.2207148460614;1230.1696354960366;1259.7732408166619;1293.4632127666912;1328.1964411531078;817.9141190175066;876.7895705030746;877.1886005444937;881.5988725130051;900.9369344145978;5224.843254702365;5267.920981185285;5305.6551324164575;5329.895980095305;5331.866703332447;5726.398728133569;5727.341355744143;5757;5760.971195144081;5775.653460792366;4382.671299652538;4938.481459446778;5237.528622424;5271.603025198326;5290.391604965402;2398.712154541431;2412.903483860626;2547.5159719653207;2585.8060645451665;2611.856347900846;4235.618794308465;4554.977225113853;4753.239481682914;5076.314697515862;5092.694438333712;4467.642588592905;4509.436320459942;4831;5039.773210205476;5134.897302053938;4695.929561056519;4708.788104535304;5119.87200319995;5124.64266437443;5152.252923326172;4581.908361832678;4615.769211539342;4779.733370656709;4863.537963893425;4965.3614307277785;3456.5160877477674;4310.568943105664;4356.956430435655;4847.200211964986;4907.4847141051105;4194.790260486902;4622.445306563234;4683.805629564439;4799.3760811094335;4915.901681966412;2728.399752054545;2945.705429457123;3051.5727798107837;3334;3359.6640335967186;4519.9152203471585;4836.839158601981;4943.480934501826;4996.15065438869;5612.466815652507;4942.6293028023765;4948.703077815343;5588.692621905834;5624.493795558255;5674.304705264966;4574.4510658721165;5600.347897370367;5613.214150018919;5623.766334357842;5664.886702265849;5270.235815806764;5494.2033405155225;5512.531434827924;5560.944390556043;5567.192757050286;5633.155026746021;5657.991413048473;5660.7169641518585;5665.178549110438;5677.744501497526;4830.903381932412;5094.592432605456;5528.861778455571;5558.861028474321;5571.693556854412 03:21:43 INFO - PROCESS | 1679 | |5;yui.html;630.2153818495967;679.4394624434842;704.5948579566747;721.8954998851758;768.646422645583;14955.850441495595;15680.529584112466;15780.684386312267;15790.92104539477;15801.920990395032;11970.461329240183;14156.292185390716;14228;14235;14241.074330168532;667.5894324990145;692.4218277738095;830.5390508267894;834.6160766047595;862.0818827948215;844.4637655089001;863.6847550644001;871.4553404122423;873.5588527793456;873.6461732998114;890.9465432074096;915.5422288855572;916.0198587511366;918.8621706744009;920.6547544670749;868.917452841979;897.1477096758106;904.4754042655244;910.8406028944942;911.9179273865351;674.5177198303188;679.9864002719918;685.4482141875789;687.3676217879563;688.7141836137997;14792.11247325153;14799.482018129314;14802.11187328753;14809.33357998882;14829.332680029425;14457.638559036002;14495.565133046026;14525.854741452556;14553.490627827976;14583.562493125222;11484.655460336204;11804;11875.643730688093;11952.282863028158;12338;3760.899986553988;3815.6947444204397;3838.8272527736317;3912.765234085964;3915.5888631693833;106639;106705.39941900878;110555;111877.44061279723;112549.43725281321;11002.284851484628;11189.720256993478;11193.832092518618;11264.04634670136;11265.54937802495;22814.885925570597;22860.971256293506;22922.885385572965;23025.88487057554;23316.7668323318;7994.760157195294;8019.639116239783;8031.919680803234;8033.959830200812;8120.390970677223;4233.153369326147;4317.266064768997;4458.264386376277;4470.821167153343;4484.394606728115;3642.5264715586804;3761.078535758702;3773.132179598708;3780.3006443807985;3788.981055094707;651.5211319680031;660.600336796241;661.3783043938682;675.8648270345852;683.4259222253331;551.3191208857058;625.9311475737666;657.9539432239698;667.0827612033454;671.691022129816;8920.553972301488;9557.61769529211;9761.463119528495;9797.80404391908;9821.508924553744;603.9003564411911;607.1772747926584;626.4706323156925;657.6613044282199;694.1462001737891;4407.2507673695545;4747.83382581608;4768.642351823627;4809.350737650442;4877.097736918681;145767.27116364564;160716.39283607248;164889;166178;171008.14495927442;117919.41040294744;125316.74683253233;127395;128094.35952820176;130960;97135;102231;111731;113559.42370949493;123037;7613.961930190314;8607.397482176188;8935.374523783532;9294.676330917271;9481.146696797321;36638.81680591687;46508.7674561625;47602.52397475981;58079.41920580909;58082.4191758077;77748;88682;95052.04947950432;95348.52325738326;98281.52577711196;10001.34991225568;10433.165346772392;10468.110210632181;10520.579176832842;10930.180236482454;12469.5012199511;12529.93735031319;12577.874221258036;12578.874211258137;12589.685257868627;11123.388213648326;11950.163488556065;12040.458179381774;12067;12433.440495177558;11966.102542309536;12016.218945768496;12050.939745301217;12067.637970860887;12073.396330183632;11859.051275897735;11927.284362938251;11947.940260298643;12339.383030848601;12417.937910310391;9678.983706710695;10901.509432075734;11248;11398;11408.372539510076;9845;10080.395176289152;10487.318324308895;10575;11051.83422248683 03:21:43 INFO - PROCESS | 1679 | __end_tp_report 03:21:43 INFO - PROCESS | 1679 | __start_cc_report 03:21:43 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,360 03:21:43 INFO - PROCESS | 1679 | __end_cc_report 03:21:43 INFO - PROCESS | 1679 | __startTimestamp1477131703810__endTimestamp 03:21:43 INFO - PROCESS | 1679 | 03:21:43 INFO - PROCESS | 1679 | ------- Summary: start ------- 03:21:43 INFO - PROCESS | 1679 | Number of tests: 6 03:21:43 INFO - PROCESS | 1679 | 03:21:43 INFO - PROCESS | 1679 | [#0] dojo.html Cycles:165 Average:5608.58 Median:5846.04 stddev:728.35 (12.5%) stddev-sans-first:696.98 03:21:43 INFO - PROCESS | 1679 | Values: 2820.8 2825.4 2873.9 2918.7 2946.6 4309.3 5439.2 5599.0 5644.2 5655.9 4945.9 5335.8 5629.3 5630.4 5656.0 5190.9 5221.8 5234.3 5245.5 5258.9 4386.8 5175.8 5195.6 5259.3 5318.0 5152.4 5160.5 5231.3 5231.9 5285.2 4315.2 5179.8 5182.1 5256.9 5332.1 5127.8 5198.8 5202.7 5211.1 5227.3 4351.8 4785.5 5491.2 5649.1 5746.9 6054.6 6062.4 6063.8 6086.3 6109.3 6134.9 6164.5 6166.9 6192.0 6202.9 5716.5 5717.4 5728.0 5732.3 5742.3 6168.8 6187.6 6207.5 6218.4 6280.5 6096.6 6100.3 6103.3 6113.1 6121.9 6203.0 6206.2 6232.7 6245.2 6263.6 5946.6 6004.2 6020.1 6082.3 6101.5 6159.2 6187.5 6198.9 6209.7 6219.3 4829.0 4870.9 4879.9 4884.4 4894.5 4251.8 4284.4 4330.5 4388.9 4392.5 5703.3 5800.6 5842.5 5842.6 5842.7 5653.3 6246.6 6247.4 6259.7 6290.2 5603.0 5701.3 5726.9 5777.9 5794.1 5328.1 5342.5 5362.9 5366.1 5366.6 6278.8 6288.2 6289.7 6290.8 6297.1 6042.8 6071.7 6135.5 6136.7 6238.1 5227.0 6261.1 6266.8 6275.5 6284.2 6069.2 6095.8 6109.4 6113.7 6123.4 6098.9 6125.1 6186.9 6194.6 6219.1 4355.5 5950.5 6075.8 6090.8 6126.0 4977.9 5866.7 6038.1 6041.5 6065.4 4536.6 5846.0 5891.0 5935.9 5958.2 5819.1 5878.8 5971.0 5999.3 6000.5 4804.8 5876.0 5878.4 5897.8 5919.6 03:21:43 INFO - PROCESS | 1679 | 03:21:43 INFO - PROCESS | 1679 | [#1] ext.html Cycles:180 Average:69136.34 Median:40165.70 stddev:151671.98 (377.6%) stddev-sans-first:152009.83 03:21:43 INFO - PROCESS | 1679 | Values: 466.9 483.3 501.7 525.9 528.5 39229.4 41079.0 41132.6 43828.8 43901.8 42842.6 42927.1 43326.6 43410.8 43433.6 9733.0 9915.1 9926.5 9927.3 9939.5 9729.0 9793.7 9809.2 9829.1 9829.9 9752.4 9772.7 9786.1 9797.4 9815.0 8731.9 9540.9 9784.3 9784.5 9820.4 9771.6 9844.5 9857.4 9858.5 9859.5 40637.8 40828.6 40890.2 41014.2 41099.6 3249.4 3612.1 3612.7 3842.2 3850.6 29475.9 30789.7 31533.2 31736.0 32011.5 3199.0 3238.3 3249.4 3312.4 3440.1 498038.0 502199.0 504728.0 505181.0 507067.0 59442.1 59541.0 59739.4 59768.0 59932.0 34038.3 34469.0 34828.8 36368.8 61458.4 14761.2 17299.9 17310.3 17320.5 17325.7 12441.8 12875.5 13132.9 13231.6 13238.3 19188.4 19217.2 19322.6 19404.6 19413.2 6796.9 7101.0 7675.0 7986.9 7998.0 883.5 968.5 969.7 1007.6 1052.2 28923.4 29072.6 29234.7 29406.3 30893.1 918.0 1013.5 1060.1 1061.5 1068.5 13528.9 13593.5 13629.6 14359.7 16739.2 510541.0 655774.0 662455.0 671177.0 671398.0 57303.4 57717.7 58309.4 58407.7 59100.4 1366.2 1376.5 1389.7 1395.8 1401.8 28551.7 29162.9 30379.0 30470.0 31234.4 46278.5 48708.8 50395.5 50441.5 50623.7 530562.0 531501.0 531761.0 535525.0 631095.0 25281.4 25877.2 26178.0 26203.2 26318.9 45568.8 45702.5 45769.5 46607.5 46714.3 37875.9 38355.2 38614.4 39069.0 39661.8 38655.4 38906.0 39468.8 39573.8 39693.6 35780.8 36059.5 36199.5 36620.8 36853.4 32755.0 33654.5 34116.8 34587.5 34689.1 19300.8 25230.0 25399.2 25643.7 26077.0 03:21:43 INFO - PROCESS | 1679 | 03:21:43 INFO - PROCESS | 1679 | [#2] jquery.html Cycles:180 Average:35088.82 Median:17289.83 stddev:101809.96 (588.8%) stddev-sans-first:102062.07 03:21:43 INFO - PROCESS | 1679 | Values: 307.7 307.7 362.7 379.9 382.8 19734.9 19953.5 20241.9 20563.7 20855.1 16478.5 17381.0 19769.2 19958.1 20295.4 5301.6 5705.2 5797.6 5954.7 5978.6 5743.2 6086.6 6133.9 6191.3 6199.0 5940.4 6114.9 6183.1 6184.9 6191.2 6178.1 6208.8 6209.5 6214.4 6246.9 5769.7 5998.5 6003.4 6047.2 6068.5 12814.9 12997.2 13098.3 18798.9 25295.4 2333.1 2420.0 2856.9 3005.6 3039.1 9856.5 10072.6 10221.0 12137.5 15708.5 1680.0 1824.8 1918.5 1938.2 1939.4 130984.3 132124.0 135157.0 135193.0 137331.3 9971.5 11438.3 11676.9 11765.9 11799.9 14499.2 14602.7 14623.8 14648.8 14660.6 8601.8 8619.1 8688.3 8705.8 8716.3 7839.8 8218.3 8695.8 8794.4 9003.3 4487.0 4491.6 4514.0 4525.5 4552.9 1682.7 1915.0 1915.5 1937.3 1972.2 829.4 893.0 908.4 928.8 963.5 20542.2 21316.7 21341.9 21506.8 21580.4 901.8 925.5 928.1 974.3 978.4 8415.9 10772.0 10917.1 11085.2 11097.8 581217.0 608135.0 609685.0 622570.0 623207.0 91538.0 117074.4 117268.4 134422.0 141214.0 954.7 960.1 975.4 985.1 985.6 15748.0 18634.8 18857.0 19384.2 19451.5 34217.0 49993.0 51054.5 52656.0 54519.2 58816.0 72302.0 75157.0 80060.0 83858.0 7148.6 8205.5 8210.3 8298.0 8345.0 11059.3 13024.2 13135.0 13238.4 13560.4 5199.8 5415.7 11262.8 11352.8 11439.3 10964.7 11328.8 11455.1 11577.7 11661.8 11384.3 11614.8 11680.3 11777.8 11987.7 8058.0 8101.3 8322.9 8336.5 8495.1 9895.5 11415.7 11703.9 11779.0 11909.9 03:21:43 INFO - PROCESS | 1679 | 03:21:43 INFO - PROCESS | 1679 | [#3] mootools.html Cycles:180 Average:5740.14 Median:2520.43 stddev:3236.07 (128.4%) stddev-sans-first:3228.42 03:21:43 INFO - PROCESS | 1679 | Values: 1362.2 1530.5 1740.0 1851.5 1908.5 8085.2 8335.2 8509.0 9065.5 9091.1 7894.8 8816.5 8833.3 8905.0 8917.1 2360.3 2389.8 2391.2 2394.0 2404.8 2364.3 2369.6 2403.3 2405.3 2413.3 2153.8 2300.3 2390.5 2407.6 2411.5 2371.1 2386.3 2390.6 2396.7 2398.4 2377.4 2391.8 2392.5 2396.3 2396.7 8892.1 8938.7 9008.7 9028.4 9037.4 5275.5 5440.8 5444.4 5455.6 5458.5 3604.8 3645.4 3648.3 3716.3 3718.0 1082.7 1097.0 1098.1 1100.6 1107.0 11046.7 11819.3 11872.4 11881.9 11883.5 4601.8 4680.0 4838.8 4861.9 4862.0 10026.1 10062.6 10086.1 10093.4 10104.5 5332.7 5419.5 5426.1 5428.9 5450.8 3967.6 4407.2 4412.8 4426.1 4580.8 3969.5 4006.2 4055.8 4096.3 4121.9 1290.7 1297.2 1302.1 1308.1 1315.3 853.0 927.8 932.5 936.2 946.7 6002.8 6015.8 6046.2 6079.7 6119.3 443.9 455.3 458.0 460.1 463.4 4009.3 4026.8 4040.4 4052.8 4086.6 10179.9 10722.4 10761.1 10883.3 10919.7 10006.7 10821.7 10825.5 10841.9 10845.4 7953.1 8339.3 8366.9 8369.7 8379.7 5529.3 5589.2 5705.5 5743.9 5790.5 9824.0 10099.7 10196.2 10199.1 10209.7 9971.8 10275.6 10285.4 10375.9 10465.3 5634.9 7217.7 7402.9 7484.3 7593.8 8404.2 8466.4 8509.6 8514.7 8582.7 7394.3 7471.1 7636.0 7672.5 7715.7 7238.3 7455.2 7456.4 7501.7 7660.8 6698.6 7065.4 7111.0 7144.4 7158.9 4907.5 5012.1 5015.4 5028.1 5147.9 5057.0 5075.8 5146.4 5173.3 5198.0 03:21:43 INFO - PROCESS | 1679 | 03:21:43 INFO - PROCESS | 1679 | [#4] prototype.html Cycles:180 Average:4308.30 Median:4713.49 stddev:1348.56 (28.6%) stddev-sans-first:1318.33 03:21:43 INFO - PROCESS | 1679 | Values: 298.4 300.3 307.1 310.4 312.5 5149.2 5320.0 5332.4 5391.0 5496.9 3914.7 4528.0 4718.2 5005.2 5333.9 3361.3 3516.4 4078.0 4088.5 4115.4 3371.1 3830.8 4059.4 4096.1 4106.4 3269.7 3538.0 3997.7 4023.0 4042.7 2988.1 3780.3 3888.9 4008.3 4045.5 3331.5 3491.0 3505.9 3509.7 3578.9 3891.6 4936.8 5120.8 5125.6 5131.5 4567.8 4568.3 4570.7 4581.2 4624.6 4593.8 5340.5 5583.4 5611.9 5650.5 3339.4 3710.6 3760.1 3842.0 3847.8 5190.4 5778.3 5925.2 5961.3 5961.8 3874.2 3897.7 3905.6 3910.6 3916.6 3354.7 3553.9 3725.5 3969.4 3969.7 3771.8 4444.8 4543.7 4565.9 4569.2 4730.4 5675.7 5686.8 5706.0 5719.8 1227.2 1230.2 1259.8 1293.5 1328.2 817.9 876.8 877.2 881.6 900.9 5224.8 5267.9 5305.7 5329.9 5331.9 5726.4 5727.3 5757.0 5761.0 5775.7 4382.7 4938.5 5237.5 5271.6 5290.4 2398.7 2412.9 2547.5 2585.8 2611.9 4235.6 4555.0 4753.2 5076.3 5092.7 4467.6 4509.4 4831.0 5039.8 5134.9 4695.9 4708.8 5119.9 5124.6 5152.3 4581.9 4615.8 4779.7 4863.5 4965.4 3456.5 4310.6 4357.0 4847.2 4907.5 4194.8 4622.4 4683.8 4799.4 4915.9 2728.4 2945.7 3051.6 3334.0 3359.7 4519.9 4836.8 4943.5 4996.2 5612.5 4942.6 4948.7 5588.7 5624.5 5674.3 4574.5 5600.3 5613.2 5623.8 5664.9 5270.2 5494.2 5512.5 5560.9 5567.2 5633.2 5658.0 5660.7 5665.2 5677.7 4830.9 5094.6 5528.9 5558.9 5571.7 03:21:43 INFO - PROCESS | 1679 | 03:21:43 INFO - PROCESS | 1679 | [#5] yui.html Cycles:180 Average:24508.81 Median:3767.11 stddev:40366.39 (1071.5%) stddev-sans-first:40439.81 03:21:43 INFO - PROCESS | 1679 | Values: 630.2 679.4 704.6 721.9 768.6 14955.9 15680.5 15780.7 15790.9 15801.9 11970.5 14156.3 14228.0 14235.0 14241.1 667.6 692.4 830.5 834.6 862.1 844.5 863.7 871.5 873.6 873.6 890.9 915.5 916.0 918.9 920.7 868.9 897.1 904.5 910.8 911.9 674.5 680.0 685.4 687.4 688.7 14792.1 14799.5 14802.1 14809.3 14829.3 14457.6 14495.6 14525.9 14553.5 14583.6 11484.7 11804.0 11875.6 11952.3 12338.0 3760.9 3815.7 3838.8 3912.8 3915.6 106639.0 106705.4 110555.0 111877.4 112549.4 11002.3 11189.7 11193.8 11264.0 11265.5 22814.9 22861.0 22922.9 23025.9 23316.8 7994.8 8019.6 8031.9 8034.0 8120.4 4233.2 4317.3 4458.3 4470.8 4484.4 3642.5 3761.1 3773.1 3780.3 3789.0 651.5 660.6 661.4 675.9 683.4 551.3 625.9 658.0 667.1 671.7 8920.6 9557.6 9761.5 9797.8 9821.5 603.9 607.2 626.5 657.7 694.1 4407.3 4747.8 4768.6 4809.4 4877.1 145767.3 160716.4 164889.0 166178.0 171008.1 117919.4 125316.7 127395.0 128094.4 130960.0 97135.0 102231.0 111731.0 113559.4 123037.0 7614.0 8607.4 8935.4 9294.7 9481.1 36638.8 46508.8 47602.5 58079.4 58082.4 77748.0 88682.0 95052.0 95348.5 98281.5 10001.3 10433.2 10468.1 10520.6 10930.2 12469.5 12529.9 12577.9 12578.9 12589.7 11123.4 11950.2 12040.5 12067.0 12433.4 11966.1 12016.2 12050.9 12067.6 12073.4 11859.1 11927.3 11947.9 12339.4 12417.9 9679.0 10901.5 11248.0 11398.0 11408.4 9845.0 10080.4 10487.3 10575.0 11051.8 03:21:43 INFO - PROCESS | 1679 | -------- Summary: end -------- 03:21:43 INFO - PROCESS | 1679 | 03:21:44 INFO - TEST-INFO | 1679: exit 0 03:21:44 INFO - TEST-OK | dromaeo_css | took 1112455ms 03:21:44 INFO - TEST-START | kraken 03:21:44 INFO - operating with platform_type : mac_ 03:21:44 INFO - Initialising browser for kraken test... 03:21:44 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpk0QMxi/profile http://localhost:49274/getInfo.html) 03:21:47 INFO - PROCESS | 1686 | __metrics Screen width/height:1600/1200 03:21:47 INFO - PROCESS | 1686 | colorDepth:24 03:21:47 INFO - PROCESS | 1686 | Browser inner width/height: 1024/689 03:21:47 INFO - PROCESS | 1686 | __metrics 03:21:47 ERROR - PROCESS | 1686 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:21:47 INFO - TEST-INFO | 1686: exit 0 03:21:47 INFO - Browser initialized. 03:21:47 INFO - Running cycle 1/1 for kraken test... 03:21:47 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpk0QMxi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:59 INFO - PROCESS | 1689 | RSS: Main: 225259520 03:21:59 INFO - PROCESS | 1689 | 03:22:02 INFO - PROCESS | 1689 | 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) 03:22:03 INFO - PROCESS | 1689 | RSS: Main: 237830144 03:22:03 INFO - PROCESS | 1689 | 03:22:05 INFO - PROCESS | 1689 | 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) 03:22:06 INFO - PROCESS | 1689 | RSS: Main: 245280768 03:22:06 INFO - PROCESS | 1689 | 03:22:09 INFO - PROCESS | 1689 | 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) 03:22:10 INFO - PROCESS | 1689 | RSS: Main: 249118720 03:22:10 INFO - PROCESS | 1689 | 03:22:12 INFO - PROCESS | 1689 | 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) 03:22:12 INFO - PROCESS | 1689 | RSS: Main: 249630720 03:22:12 INFO - PROCESS | 1689 | 03:22:14 INFO - PROCESS | 1689 | 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) 03:22:15 INFO - PROCESS | 1689 | RSS: Main: 249503744 03:22:15 INFO - PROCESS | 1689 | 03:22:18 INFO - PROCESS | 1689 | 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) 03:22:18 INFO - PROCESS | 1689 | RSS: Main: 249765888 03:22:18 INFO - PROCESS | 1689 | 03:22:21 INFO - PROCESS | 1689 | 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) 03:22:22 INFO - PROCESS | 1689 | RSS: Main: 251142144 03:22:22 INFO - PROCESS | 1689 | 03:22:25 INFO - PROCESS | 1689 | 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) 03:22:25 INFO - PROCESS | 1689 | RSS: Main: 251572224 03:22:25 INFO - PROCESS | 1689 | 03:22:27 INFO - PROCESS | 1689 | 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) 03:22:28 INFO - PROCESS | 1689 | RSS: Main: 251486208 03:22:28 INFO - PROCESS | 1689 | 03:22:29 INFO - PROCESS | 1689 | 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) 03:22:30 INFO - PROCESS | 1689 | RSS: Main: 251322368 03:22:30 INFO - PROCESS | 1689 | 03:22:32 INFO - PROCESS | 1689 | 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) 03:22:33 INFO - PROCESS | 1689 | RSS: Main: 251285504 03:22:33 INFO - PROCESS | 1689 | 03:22:36 INFO - PROCESS | 1689 | 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) 03:22:36 INFO - PROCESS | 1689 | RSS: Main: 251338752 03:22:36 INFO - PROCESS | 1689 | 03:22:39 INFO - PROCESS | 1689 | 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) 03:22:40 INFO - PROCESS | 1689 | RSS: Main: 251641856 03:22:40 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | 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) 03:22:42 INFO - PROCESS | 1689 | RSS: Main: 253476864 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | __start_tp_report 03:22:42 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 03:22:42 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 03:22:42 INFO - PROCESS | 1689 | |i|pagename|runs| 03:22:42 INFO - PROCESS | 1689 | |0;ai-astar;107;115;118;118;120;118;118;118;118;117 03:22:42 INFO - PROCESS | 1689 | |1;audio-beat-detection;145;109;115;168;138;116;109;109;142;110 03:22:42 INFO - PROCESS | 1689 | |2;audio-dft;202;201;196;196;194;196;197;196;196;195 03:22:42 INFO - PROCESS | 1689 | |3;audio-fft;78;59;58;84;58;55;73;82;100;81 03:22:42 INFO - PROCESS | 1689 | |4;audio-oscillator;89;69;88;74;69;69;88;69;70;89 03:22:42 INFO - PROCESS | 1689 | |5;imaging-gaussian-blur;110;87;87;87;91;86;90;86;78;133 03:22:42 INFO - PROCESS | 1689 | |6;imaging-darkroom;98;129;172;106;98;97;138;100;99;97 03:22:42 INFO - PROCESS | 1689 | |7;imaging-desaturate;91;94;90;92;93;89;91;94;91;91 03:22:42 INFO - PROCESS | 1689 | |8;json-parse-financial;56;56;55;56;58;58;58;59;58;59 03:22:42 INFO - PROCESS | 1689 | |9;json-stringify-tinderbox;69;68;74;83;74;71;68;68;68;65 03:22:42 INFO - PROCESS | 1689 | |10;stanford-crypto-aes;84;86;84;82;84;82;86;83;85;90 03:22:42 INFO - PROCESS | 1689 | |11;stanford-crypto-ccm;141;141;137;134;136;135;137;144;170;140 03:22:42 INFO - PROCESS | 1689 | |12;stanford-crypto-pbkdf2;169;167;169;163;168;164;163;166;162;162 03:22:42 INFO - PROCESS | 1689 | |13;stanford-crypto-sha256-iterative;67;69;68;67;73;82;87;88;85;75 03:22:42 INFO - PROCESS | 1689 | __end_tp_report 03:22:42 INFO - PROCESS | 1689 | __start_cc_report 03:22:42 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,958 03:22:42 INFO - PROCESS | 1689 | __end_cc_report 03:22:42 INFO - PROCESS | 1689 | __startTimestamp1477131762305__endTimestamp 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | ------- Summary: start ------- 03:22:42 INFO - PROCESS | 1689 | Number of tests: 14 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#0] ai-astar Cycles:10 Average:116.70 Median:118.00 stddev:3.62 (3.1%) stddev-sans-first:1.30 03:22:42 INFO - PROCESS | 1689 | Values: 107.0 115.0 118.0 118.0 120.0 118.0 118.0 118.0 118.0 117.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:127.00 stddev:20.73 (16.3%) stddev-sans-first:20.83 03:22:42 INFO - PROCESS | 1689 | Values: 145.0 109.0 115.0 168.0 138.0 116.0 109.0 109.0 142.0 110.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#2] audio-dft Cycles:10 Average:196.90 Median:196.00 stddev:2.56 (1.3%) stddev-sans-first:1.94 03:22:42 INFO - PROCESS | 1689 | Values: 202.0 201.0 196.0 196.0 194.0 196.0 197.0 196.0 196.0 195.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#3] audio-fft Cycles:10 Average:72.80 Median:75.50 stddev:14.87 (19.7%) stddev-sans-first:15.65 03:22:42 INFO - PROCESS | 1689 | Values: 78.0 59.0 58.0 84.0 58.0 55.0 73.0 82.0 100.0 81.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:81.00 stddev:9.67 (11.9%) stddev-sans-first:9.31 03:22:42 INFO - PROCESS | 1689 | Values: 89.0 69.0 88.0 74.0 69.0 69.0 88.0 69.0 70.0 89.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:87.00 stddev:16.09 (18.5%) stddev-sans-first:15.92 03:22:42 INFO - PROCESS | 1689 | Values: 110.0 87.0 87.0 87.0 91.0 86.0 90.0 86.0 78.0 133.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:97.00 stddev:25.25 (26.0%) stddev-sans-first:26.16 03:22:42 INFO - PROCESS | 1689 | Values: 98.0 129.0 172.0 106.0 98.0 97.0 138.0 100.0 99.0 97.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#7] imaging-desaturate Cycles:10 Average:91.60 Median:91.50 stddev:1.65 (1.8%) stddev-sans-first:1.73 03:22:42 INFO - PROCESS | 1689 | Values: 91.0 94.0 90.0 92.0 93.0 89.0 91.0 94.0 91.0 91.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.00 stddev:1.42 (2.4%) stddev-sans-first:1.42 03:22:42 INFO - PROCESS | 1689 | Values: 56.0 56.0 55.0 56.0 58.0 58.0 58.0 59.0 58.0 59.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:70.00 stddev:5.14 (7.3%) stddev-sans-first:5.41 03:22:42 INFO - PROCESS | 1689 | Values: 69.0 68.0 74.0 83.0 74.0 71.0 68.0 68.0 68.0 65.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:2.37 (2.8%) stddev-sans-first:2.50 03:22:42 INFO - PROCESS | 1689 | Values: 84.0 86.0 84.0 82.0 84.0 82.0 86.0 83.0 85.0 90.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:140.50 stddev:10.49 (7.5%) stddev-sans-first:11.13 03:22:42 INFO - PROCESS | 1689 | Values: 141.0 141.0 137.0 134.0 136.0 135.0 137.0 144.0 170.0 140.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.50 stddev:2.83 (1.7%) stddev-sans-first:2.67 03:22:42 INFO - PROCESS | 1689 | Values: 169.0 167.0 169.0 163.0 168.0 164.0 163.0 166.0 162.0 162.0 03:22:42 INFO - PROCESS | 1689 | 03:22:42 INFO - PROCESS | 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:78.50 stddev:8.61 (11.0%) stddev-sans-first:8.48 03:22:42 INFO - PROCESS | 1689 | Values: 67.0 69.0 68.0 67.0 73.0 82.0 87.0 88.0 85.0 75.0 03:22:42 INFO - PROCESS | 1689 | -------- Summary: end -------- 03:22:42 INFO - PROCESS | 1689 | 03:22:43 INFO - TEST-INFO | 1689: exit 0 03:22:43 INFO - TEST-OK | kraken | took 58726ms 03:22:43 INFO - SUITE-END | took 1171s 03:22:43 INFO - Completed test suite (00:19:31) 03:22:43 INFO - javascript benchmark 03:22:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7209.231061245463, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2820.815257591811, 2825.350169461024, 2873.8850445982157, 2918.730352296751, 2946.5580162975566, 4309.288967320388, 5439.238506609078, 5599.0, 5644.20981062651, 5655.8586035349035, 4945.9258111128365, 5335.759890804913, 5629.268195134637, 5630.352509461413, 5656.038473459512, 5190.896182076356, 5221.817236396727, 5234.345706786652, 5245.4754524547625, 5258.894822103555, 4386.8025938832825, 5175.844724658266, 5195.636305458619, 5259.289995850569, 5317.973410132944, 5152.355955505562, 5160.535551800356, 5231.346081739783, 5231.947680523184, 5285.154375299952, 4315.201687687756, 5179.844604661847, 5182.093133701606, 5256.92114618281, 5332.066888294533, 5127.769250383742, 5198.818041368534, 5202.713850738208, 5211.088059589557, 5227.26818245446, 4351.825926962918, 4785.545373189541, 5491.203775452537, 5649.096144616883, 5746.942530574683, 6054.576179667425, 6062.393760623902, 6063.818085457443, 6086.269647642312, 6109.297430795426, 6134.907976380313, 6164.537659675498, 6166.907496387557, 6192.0, 6202.906956395657, 5716.514096301819, 5717.399673034354, 5727.968965586235, 5732.283464566929, 5742.3396309424115, 6168.845778855564, 6187.597806142587, 6207.472364848948, 6218.378162183745, 6280.528960327993, 6096.634201947809, 6100.328963813977, 6103.298120716086, 6113.052476866093, 6121.908171377433, 6203.0, 6206.224221972254, 6232.719527621268, 6245.219347581552, 6263.561550691408, 5946.583739138306, 6004.219451471281, 6020.127081573148, 6082.2701275847185, 6101.511879049665, 6159.23009623797, 6187.474064704461, 6198.938010619926, 6209.6895155242055, 6219.284782250009, 4828.95171048285, 4870.9269360959615, 4879.926416188433, 4884.3650325457465, 4894.510548945077, 4251.829926802893, 4284.400183974246, 4330.501992270929, 4388.868333949987, 4392.472903251631, 5703.344115426696, 5800.59395842287, 5842.474177324061, 5842.59101862874, 5842.737076831553, 5653.293338332708, 6246.625202487865, 6247.437730604177, 6259.71831267594, 6290.150829638032, 5603.0, 5701.344345400332, 5726.885462290814, 5777.913331300034, 5794.1308803679785, 5328.120860058125, 5342.492463215988, 5362.892742145135, 5366.060939335601, 5366.597505187126, 6278.843028924222, 6288.151099601587, 6289.7169627366875, 6290.842728931813, 6297.055441683784, 6042.788502402394, 6071.726772295169, 6135.478484328882, 6136.723847426787, 6238.126662267377, 5227.032998895216, 6261.123442718114, 6266.811995640138, 6275.497960163268, 6284.151639528788, 6069.180660610761, 6095.847603809941, 6109.358517355614, 6113.663748493876, 6123.418275263843, 6098.9390106100145, 6125.143885071339, 6186.907196391968, 6194.628322300677, 6219.129321895029, 4355.499117601516, 5950.464458198783, 6075.817725468243, 6090.847728806815, 6126.0, 4977.925331119964, 5866.7066646668345, 6038.064100064497, 6041.516678665608, 6065.3934606539, 4536.591706746409, 5846.035404158266, 5890.970545147418, 5935.881282374415, 5958.19564358806, 5819.0689489681445, 5878.764849405976, 5971.0, 5999.250093738283, 6000.549958753199, 4804.783784729765, 5876.030454974882, 5878.412158784087, 5897.823065308047, 5919.644821310735], "value": 5556.996795532499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.92529195328757, 483.2557860894222, 501.6839391183554, 525.8764190415252, 528.4636094364218, 39229.41155882661, 41078.973025674335, 41132.588674113285, 43828.78085609576, 43901.78049109758, 42842.57157428425, 42927.14145717092, 43326.56673433265, 43410.7829460853, 43433.56566434335, 9732.999999999982, 9915.058069483424, 9926.503674816266, 9927.305088643798, 9939.453330066843, 9728.951355243214, 9793.657221997231, 9809.21526277896, 9829.115379615832, 9829.901700983006, 9752.36609620376, 9772.706818795448, 9786.119249267564, 9797.412155270707, 9815.0, 8731.869021964676, 9540.855097388358, 9784.315097943147, 9784.510774461283, 9820.36167649104, 9771.560279787427, 9844.507774611313, 9857.408555486694, 9858.507074646239, 9859.457729824857, 40637.79681101605, 40828.59171408307, 40890.159942802646, 41014.1797164058, 41099.589004109876, 3249.382617302705, 3612.1330880588735, 3612.71098312137, 3842.212346468967, 3850.614938506127, 29475.852620736972, 30789.69210307913, 31533.211669708213, 31736.0, 32011.51982720261, 3199.0, 3238.3199528098894, 3249.382617302705, 3312.403767321881, 3440.139965008748, 498037.9999999964, 502199.0, 504728.0, 505181.0, 507067.0, 59442.10836837451, 59541.0, 59739.402605974254, 59768.0, 59932.0, 34038.31923361519, 34468.96593102211, 34828.82585587056, 36368.81815590905, 61458.38541614527, 14761.188134652697, 17299.875508092184, 17310.307587696603, 17320.480385588453, 17325.65348693019, 12441.75116497665, 12875.484980600671, 13132.868671313356, 13231.603051908458, 13238.338083095807, 19188.424347269603, 19217.231310747695, 19322.613547728968, 19404.611907761766, 19413.223471061, 6796.93203067963, 7101.0, 7674.963879876145, 7986.880196797053, 7998.040724931812, 883.4831623500196, 968.4867020479016, 969.7199696400684, 1007.6473234367912, 1052.2160990062453, 28923.42153156925, 29072.563911541343, 29234.7076529232, 29406.26484337866, 30893.06668664029, 917.9816403671889, 1013.4679293371039, 1060.1412855587, 1061.4639606998417, 1068.5458680060942, 13528.932355338357, 13593.456261749618, 13629.647378299596, 14359.712805743826, 16739.246733897005, 510541.0, 655774.0, 662455.0, 671177.0, 671398.0, 57303.42696573064, 57717.71141144352, 58309.41690583125, 58407.70796146077, 59100.40899591035, 1366.2485632901864, 1376.504458394977, 1389.7290028444356, 1395.8255218097738, 1401.7546929287537, 28551.714482854906, 29162.854185728935, 30379.0, 30470.0, 31234.375312494078, 46278.537214627424, 48708.756456217496, 50395.49604504055, 50441.49558504368, 50623.74688126536, 530562.0, 531501.0, 531761.0, 535525.0, 631095.0, 25281.367965801, 25877.223683289532, 26177.95288188451, 26203.213903582924, 26318.86840565785, 45568.772156139006, 45702.54297457116, 45769.54230457653, 46607.53392466032, 46714.29928551142, 37875.86372408832, 38355.232895342495, 38614.4207836877, 39069.0, 39661.80169099136, 38655.42016869693, 38906.0, 39468.80265598654, 39573.80213098916, 39693.60306397015, 35780.82109589539, 36059.45910811392, 36199.45700814542, 36620.81689591535, 36853.44719829258, 32755.0, 33654.495182571794, 34116.829415853754, 34587.48118778271, 34689.1327716799, 19300.8069919299, 25230.0, 25399.238022859343, 25643.743562564134, 26077.0], "value": 19770.58224744711, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.65081632347284, 307.66310889575914, 362.6591004455813, 379.9418619145678, 382.77416324368653, 19734.90132549337, 19953.501162470944, 20241.886696231737, 20563.691544626843, 20855.0615222315, 16478.505644830646, 17381.044042577683, 19769.209231630717, 19958.101885415155, 20295.391138265837, 5301.628885977983, 5705.201271821938, 5797.5795929997, 5954.732037058343, 5978.611390259619, 5743.224664670279, 6086.634801911878, 6133.877322453548, 6191.288001879797, 6199.0, 5940.435658612425, 6114.8777024459705, 6183.072539119124, 6184.938150618481, 6191.226096737908, 6178.135061091451, 6208.75164993402, 6209.472194863442, 6214.440700336946, 6246.875062498747, 5769.682667453289, 5998.490128339096, 6003.369646187175, 6047.21386219793, 6068.453839154453, 12814.871851281461, 12997.15518491295, 13098.34508274592, 18798.906005469886, 25295.36761580957, 2333.1367394064305, 2419.987900060506, 2856.9142925712263, 3005.6393232811984, 3039.149038269288, 9856.50717464131, 10072.647457339031, 10221.0, 12137.453814578364, 15708.507691769379, 1679.9580010499712, 1824.8229891719766, 1918.5299601597558, 1938.176275083084, 1939.4375631066973, 130984.345078274, 132124.0, 135157.0, 135193.0, 137331.31334343363, 9971.501424928725, 11438.256513326607, 11676.883231167749, 11765.882241187073, 11799.88200118005, 14499.202543859978, 14602.707945841024, 14623.78064329036, 14648.780268295985, 14660.633484162981, 8601.827963440695, 8619.094995025558, 8688.304935605136, 8705.823544113971, 8716.259117974916, 7839.804004899923, 8218.301444377295, 8695.826083478421, 8794.42836215644, 9003.279737620975, 4487.0, 4491.618212451978, 4514.029483661028, 4525.479569849509, 4552.931706024412, 1682.6971145193738, 1915.0466524145572, 1915.52111972007, 1937.321937321926, 1972.2447022150297, 829.3986859526915, 893.0, 908.3868388837508, 928.763165392834, 963.5182408795603, 20542.17831286732, 21316.680249796267, 21341.893290533757, 21506.784932150476, 21580.352589422342, 901.8286525560122, 925.5233554719325, 928.1228192603012, 974.3277138774223, 978.4178413843894, 8415.895916270032, 10772.030517253485, 10917.126629869592, 11085.168612354106, 11097.834727353511, 581217.0, 608135.0, 609685.0, 622570.0, 623207.0, 91538.0, 117074.41462792802, 117268.41365793116, 134422.0, 141214.0, 954.656323723459, 960.078324808178, 975.4244995452575, 985.0592683986775, 985.640241311916, 15748.0, 18634.813651863307, 18857.0, 19384.2246310146, 19451.51371215731, 34217.0, 49993.0, 51054.48945510497, 52656.0, 54519.18221226764, 58816.0, 72302.0, 75157.0, 80060.0, 83858.0, 7148.606826624586, 8205.507669539847, 8210.261076503144, 8298.045724741733, 8344.998600168019, 11059.336439813636, 13024.218546887218, 13135.0, 13238.4042718076, 13560.38978246001, 5199.792008319625, 5415.729213539228, 11262.817404172773, 11352.777722247529, 11439.313641181223, 10964.671059868217, 11328.773424531628, 11455.140864435367, 11577.6526704199, 11661.76676466483, 11384.316940983568, 11614.825777613174, 11680.299182049104, 11777.822217778154, 11987.700307492034, 8058.0, 8101.270885620323, 8322.875156872531, 8336.541490218096, 8495.065542790164, 9895.455749933823, 11415.714607134889, 11703.882961170279, 11779.0, 11909.940450297692], "value": 9482.392516573622, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.1758835904277, 1530.53318737785, 1740.0, 1851.5093500222436, 1908.4751693284336, 8085.191480851912, 8335.249827515523, 8508.95745521273, 9065.546722663865, 9091.136342047512, 7894.842103157934, 8816.471011739284, 8833.293336533077, 8904.95547522263, 8917.10828917108, 2360.280114565057, 2389.808815294772, 2391.151141344824, 2394.0064873077654, 2404.843685160468, 2364.337985364101, 2369.644553316999, 2403.3270684208364, 2405.2663937499055, 2413.2880800163907, 2153.7630860605323, 2300.309907027885, 2390.4501964548163, 2407.6027455469825, 2411.505641343529, 2371.1108334374608, 2386.307970688507, 2390.569697454449, 2396.6698482342294, 2398.436367453647, 2377.393764590036, 2391.8206134539805, 2392.485615592656, 2396.2930935373934, 2396.6884305040408, 8892.066333035003, 8938.687145949925, 9008.684696035672, 9028.368014239006, 9037.367384283103, 5275.525202731773, 5440.809571664972, 5444.40111587725, 5455.5908306876745, 5458.4814442627885, 3604.819759012039, 3645.3620616392027, 3648.252108317815, 3716.2753263113705, 3717.9814100929593, 1082.7401423658266, 1096.950637221327, 1098.0885864732254, 1100.5762781329165, 1107.03687791621, 11046.723831904266, 11819.290842549475, 11872.40637968098, 11881.94059029708, 11883.465244064038, 4601.838935637304, 4679.976600117046, 4838.830640927551, 4861.927071093936, 4861.978984413242, 10026.09765121128, 10062.597496100221, 10086.092251697382, 10093.394396336244, 10104.494775261208, 5332.653377530526, 5419.458054194628, 5426.104692725656, 5428.91856622143, 5450.809221677222, 3967.563568007517, 4407.206702793464, 4412.830599891032, 4426.092651006536, 4580.7938642761155, 3969.54350249725, 4006.1787333596544, 4055.8174882130374, 4096.303628383182, 4121.855735049319, 1290.7418516296777, 1297.202220634303, 1302.0560093931824, 1308.149702693238, 1315.3094625321783, 852.9616167272487, 927.8144371125667, 932.5150921520772, 936.166811537732, 946.7491114854569, 6002.849928751729, 6015.849603759853, 6046.183765191643, 6079.726412311456, 6119.326874043941, 443.9289713645801, 455.27838376174134, 458.02212276789294, 460.07065727231475, 463.3536216977298, 4009.3184158693093, 4026.798660066985, 4040.373742069984, 4052.756834589934, 4086.6322031016757, 10179.898201018043, 10722.41026743521, 10761.085307748928, 10883.292585981886, 10919.672409827717, 10006.69979900604, 10821.729456763644, 10825.458727063615, 10841.891581084088, 10845.403502807263, 7953.12515623281, 8339.291160251447, 8366.874496882552, 8369.707060252862, 8379.70671026511, 5529.253550770594, 5589.217509548747, 5705.543556515552, 5743.885122297447, 5790.536757059509, 9823.968483309149, 10099.7475063124, 10196.235282353704, 10199.0820826126, 10209.74475638115, 9971.800563988825, 10275.640352587623, 10285.43430111351, 10375.94812025935, 10465.267431279737, 5634.915476267941, 7217.7473788417155, 7402.851942961218, 7484.288992545699, 7593.848123037619, 8404.20160084791, 8466.449680770731, 8509.574521274035, 8514.74455766328, 8582.65669373218, 7394.260573942563, 7471.140818805907, 7636.0, 7672.5012874163, 7715.729949451742, 7238.27617238293, 7455.217202193691, 7456.4034877208605, 7501.699932002659, 7660.80847978805, 6698.56459330142, 7065.399441047363, 7110.964445177741, 7144.428445724434, 7158.928410716035, 4907.533784290486, 5012.097822392005, 5015.423226328873, 5028.069807085701, 5147.948520514747, 5057.013882293065, 5075.77159027852, 5146.408163061146, 5173.301604283524, 5198.0], "value": 4542.71178237962, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.351086387108, 300.2598594464644, 307.1216321321022, 310.4412058295068, 312.5015600117811, 5149.150390185615, 5319.973400133003, 5332.440093790149, 5390.973045134774, 5496.862578435536, 3914.725969182158, 4527.954720452794, 4718.183499352756, 5005.249212618109, 5333.893322133565, 3361.2941282330617, 3516.402211624017, 4078.0, 4088.5093788745394, 4115.403266526352, 3371.0898057524455, 3830.8276127574327, 4059.391091336294, 4096.057906681465, 4106.404571337169, 3269.6566860479666, 3537.982310088446, 3997.6801855851463, 4022.979885100585, 4042.73722208057, 2988.1035689293126, 3780.262848744496, 3888.863889763845, 4008.33862412703, 4045.4538637283886, 3331.4503106987318, 3491.022513696144, 3505.929881402383, 3509.6665816747623, 3578.9284214315567, 3891.571927088018, 4936.80252789888, 5120.820771273025, 5125.591481664688, 5131.486851314876, 4567.771611419415, 4568.314752787075, 4570.720198344469, 4581.151832460716, 4624.606908412756, 4593.770311484446, 5340.519353258225, 5583.3858275589655, 5611.859703507404, 5650.51970582501, 3339.397089397103, 3710.6474884885893, 3760.126457221904, 3841.961580384216, 3847.769133851978, 5190.377154741455, 5778.27771528559, 5925.229720136354, 5961.254843144607, 5961.761529538813, 3874.2251549690177, 3897.6881849451975, 3905.5703872573995, 3910.648041676263, 3916.6083391660604, 3354.681305275995, 3553.857845686195, 3725.535252215466, 3969.3649016157856, 3969.7419667721506, 3771.830267637963, 4444.8444304449185, 4543.65922555803, 4565.876867256675, 4569.1547063793305, 4730.432348118179, 5675.716214189274, 5686.772529098873, 5705.971470142706, 5719.799807006735, 1227.2207148460614, 1230.1696354960366, 1259.7732408166619, 1293.4632127666912, 1328.1964411531078, 817.9141190175066, 876.7895705030746, 877.1886005444937, 881.5988725130051, 900.9369344145978, 5224.843254702365, 5267.920981185285, 5305.6551324164575, 5329.895980095305, 5331.866703332447, 5726.398728133569, 5727.341355744143, 5757.0, 5760.971195144081, 5775.653460792366, 4382.671299652538, 4938.481459446778, 5237.528622424, 5271.603025198326, 5290.391604965402, 2398.712154541431, 2412.903483860626, 2547.5159719653207, 2585.8060645451665, 2611.856347900846, 4235.618794308465, 4554.977225113853, 4753.239481682914, 5076.314697515862, 5092.694438333712, 4467.642588592905, 4509.436320459942, 4831.0, 5039.773210205476, 5134.897302053938, 4695.929561056519, 4708.788104535304, 5119.87200319995, 5124.64266437443, 5152.252923326172, 4581.908361832678, 4615.769211539342, 4779.733370656709, 4863.537963893425, 4965.3614307277785, 3456.5160877477674, 4310.568943105664, 4356.956430435655, 4847.200211964986, 4907.4847141051105, 4194.790260486902, 4622.445306563234, 4683.805629564439, 4799.3760811094335, 4915.901681966412, 2728.399752054545, 2945.705429457123, 3051.5727798107837, 3334.0, 3359.6640335967186, 4519.9152203471585, 4836.839158601981, 4943.480934501826, 4996.15065438869, 5612.466815652507, 4942.6293028023765, 4948.703077815343, 5588.692621905834, 5624.493795558255, 5674.304705264966, 4574.4510658721165, 5600.347897370367, 5613.214150018919, 5623.766334357842, 5664.886702265849, 5270.235815806764, 5494.2033405155225, 5512.531434827924, 5560.944390556043, 5567.192757050286, 5633.155026746021, 5657.991413048473, 5660.7169641518585, 5665.178549110438, 5677.744501497526, 4830.903381932412, 5094.592432605456, 5528.861778455571, 5558.861028474321, 5571.693556854412], "value": 3888.028770258314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.2153818495967, 679.4394624434842, 704.5948579566747, 721.8954998851758, 768.646422645583, 14955.850441495595, 15680.529584112466, 15780.684386312267, 15790.92104539477, 15801.920990395032, 11970.461329240183, 14156.292185390716, 14228.0, 14235.0, 14241.074330168532, 667.5894324990145, 692.4218277738095, 830.5390508267894, 834.6160766047595, 862.0818827948215, 844.4637655089001, 863.6847550644001, 871.4553404122423, 873.5588527793456, 873.6461732998114, 890.9465432074096, 915.5422288855572, 916.0198587511366, 918.8621706744009, 920.6547544670749, 868.917452841979, 897.1477096758106, 904.4754042655244, 910.8406028944942, 911.9179273865351, 674.5177198303188, 679.9864002719918, 685.4482141875789, 687.3676217879563, 688.7141836137997, 14792.11247325153, 14799.482018129314, 14802.11187328753, 14809.33357998882, 14829.332680029425, 14457.638559036002, 14495.565133046026, 14525.854741452556, 14553.490627827976, 14583.562493125222, 11484.655460336204, 11804.0, 11875.643730688093, 11952.282863028158, 12338.0, 3760.899986553988, 3815.6947444204397, 3838.8272527736317, 3912.765234085964, 3915.5888631693833, 106639.0, 106705.39941900878, 110555.0, 111877.44061279723, 112549.43725281321, 11002.284851484628, 11189.720256993478, 11193.832092518618, 11264.04634670136, 11265.54937802495, 22814.885925570597, 22860.971256293506, 22922.885385572965, 23025.88487057554, 23316.7668323318, 7994.760157195294, 8019.639116239783, 8031.919680803234, 8033.959830200812, 8120.390970677223, 4233.153369326147, 4317.266064768997, 4458.264386376277, 4470.821167153343, 4484.394606728115, 3642.5264715586804, 3761.078535758702, 3773.132179598708, 3780.3006443807985, 3788.981055094707, 651.5211319680031, 660.600336796241, 661.3783043938682, 675.8648270345852, 683.4259222253331, 551.3191208857058, 625.9311475737666, 657.9539432239698, 667.0827612033454, 671.691022129816, 8920.553972301488, 9557.61769529211, 9761.463119528495, 9797.80404391908, 9821.508924553744, 603.9003564411911, 607.1772747926584, 626.4706323156925, 657.6613044282199, 694.1462001737891, 4407.2507673695545, 4747.83382581608, 4768.642351823627, 4809.350737650442, 4877.097736918681, 145767.27116364564, 160716.39283607248, 164889.0, 166178.0, 171008.14495927442, 117919.41040294744, 125316.74683253233, 127395.0, 128094.35952820176, 130960.0, 97135.0, 102231.0, 111731.0, 113559.42370949493, 123037.0, 7613.961930190314, 8607.397482176188, 8935.374523783532, 9294.676330917271, 9481.146696797321, 36638.81680591687, 46508.7674561625, 47602.52397475981, 58079.41920580909, 58082.4191758077, 77748.0, 88682.0, 95052.04947950432, 95348.52325738326, 98281.52577711196, 10001.34991225568, 10433.165346772392, 10468.110210632181, 10520.579176832842, 10930.180236482454, 12469.5012199511, 12529.93735031319, 12577.874221258036, 12578.874211258137, 12589.685257868627, 11123.388213648326, 11950.163488556065, 12040.458179381774, 12067.0, 12433.440495177558, 11966.102542309536, 12016.218945768496, 12050.939745301217, 12067.637970860887, 12073.396330183632, 11859.051275897735, 11927.284362938251, 11947.940260298643, 12339.383030848601, 12417.937910310391, 9678.983706710695, 10901.509432075734, 11248.0, 11398.0, 11408.372539510076, 9845.0, 10080.395176289152, 10487.318324308895, 10575.0, 11051.83422248683], "value": 7628.915345608897, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1483.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 118.0, 118.0, 120.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 115.0, 168.0, 138.0, 116.0, 109.0, 109.0, 142.0, 110.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 201.0, 196.0, 196.0, 194.0, 196.0, 197.0, 196.0, 196.0, 195.0], "value": 196.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 58.0, 84.0, 58.0, 55.0, 73.0, 82.0, 100.0, 81.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 88.0, 74.0, 69.0, 69.0, 88.0, 69.0, 70.0, 89.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 87.0, 87.0, 87.0, 91.0, 86.0, 90.0, 86.0, 78.0, 133.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 129.0, 172.0, 106.0, 98.0, 97.0, 138.0, 100.0, 99.0, 97.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 90.0, 92.0, 93.0, 89.0, 91.0, 94.0, 91.0, 91.0], "value": 91.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 58.0, 58.0, 58.0, 59.0, 58.0, 59.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 74.0, 83.0, 74.0, 71.0, 68.0, 68.0, 68.0, 65.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 82.0, 84.0, 82.0, 86.0, 83.0, 85.0, 90.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 137.0, 134.0, 136.0, 135.0, 137.0, 144.0, 170.0, 140.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 169.0, 163.0, 168.0, 164.0, 163.0, 166.0, 162.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 67.0, 73.0, 82.0, 87.0, 88.0, 85.0, 75.0], "value": 76.1, "unit": "score"}]}]} 03:22:43 INFO - Return code: 0 03:22:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:22:43 ERROR - # TBPL SUCCESS # 03:22:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:22:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:22:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:22:43 INFO - 2016-10-22 03:22:43.618 screenresolution[1694:19843] starting screenresolution argv=screenresolution get 03:22:43 INFO - 2016-10-22 03:22:43.621 screenresolution[1694:19843] Display 0: 1600x1200x32@60 03:22:43 INFO - 2016-10-22 03:22:43.627 screenresolution[1695:19846] starting screenresolution argv=screenresolution list 03:22:43 INFO - Available Modes on Display 0 03:22:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:22:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:22:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:22:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:22:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:22:43 INFO - Intel Iris: 03:22:43 INFO - Chipset Model: Intel Iris 03:22:43 INFO - Type: GPU 03:22:43 INFO - Bus: Built-In 03:22:43 INFO - VRAM (Dynamic, Max): 1536 MB 03:22:43 INFO - Vendor: Intel (0x8086) 03:22:43 INFO - Device ID: 0x0a2e 03:22:43 INFO - Revision ID: 0x0009 03:22:43 INFO - Displays: 03:22:43 INFO - Display: 03:22:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:22:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:22:43 INFO - Display Serial Number: 1600x1200 60 03:22:43 INFO - Main Display: Yes 03:22:43 INFO - Mirror: Off 03:22:43 INFO - Online: Yes 03:22:43 INFO - Rotation: Supported 03:22:43 INFO - Return code: 0 03:22:43 INFO - Running post-action listener: _resource_record_post_action 03:22:43 INFO - [mozharness: 2016-10-22 10:22:43.861503Z] Finished run-tests step (success) 03:22:43 INFO - Running post-run listener: _resource_record_post_run 03:22:43 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 33135616; Write bytes: 667219968; Read time: 309; Write time: 1850 03:22:43 INFO - TinderboxPrint: CPU usage
54.3% 03:22:43 INFO - TinderboxPrint: I/O read bytes / time
33,135,616 / 309 03:22:43 INFO - TinderboxPrint: I/O write bytes / time
667,219,968 / 1,850 03:22:43 INFO - TinderboxPrint: CPU idle
2,202.3 (45.7%) 03:22:43 INFO - TinderboxPrint: CPU system
970.5 (20.1%) 03:22:43 INFO - TinderboxPrint: CPU user
1,645.0 (34.1%) 03:22:43 INFO - TinderboxPrint: Swap in / out
392,347,648 / 0 03:22:43 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358584832; Write bytes: 356616192; Read time: 27598; Write time: 717 03:22:43 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 31194112; Write bytes: 299573248; Read time: 286; Write time: 1097 03:22:44 INFO - Running post-run listener: _upload_blobber_files 03:22:44 INFO - Blob upload gear active. 03:22:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:22:44 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 03:22:44 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'] 03:22:44 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 03:22:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:22:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:22:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:22:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:46 INFO - (blobuploader) - INFO - Done attempting. 03:22:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:22:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:22:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:47 INFO - (blobuploader) - INFO - Done attempting. 03:22:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:22:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:22:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:49 INFO - (blobuploader) - INFO - Done attempting. 03:22:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:22:49 INFO - Return code: 0 03:22:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:22:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:22:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ebfbe9d854efa855e1d3bef548345c499c0445963431e761d6a37a195db49d86061b5251f01658ae065f9cac8749804415ba84b396a88b4a041568747294f9c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8c0e5f44e46c97c79dd4b037fce124b7a986579a98f1950cb61f77c38e77b71ddb73b821aefdebc452854bfbf8c01b84476bbe3a2bbb3aa4a0bd54ba72a07c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfab08cbcb869deb4453404073e2f903090e198c0ba777d0e1a72a11d8d04153ca65994bab453932c9886643559b2d83b15afde15717a4de1f48a3f8cbf8aa19"} 03:22:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:22:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:22:49 INFO - Contents: 03:22:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ebfbe9d854efa855e1d3bef548345c499c0445963431e761d6a37a195db49d86061b5251f01658ae065f9cac8749804415ba84b396a88b4a041568747294f9c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8c0e5f44e46c97c79dd4b037fce124b7a986579a98f1950cb61f77c38e77b71ddb73b821aefdebc452854bfbf8c01b84476bbe3a2bbb3aa4a0bd54ba72a07c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfab08cbcb869deb4453404073e2f903090e198c0ba777d0e1a72a11d8d04153ca65994bab453932c9886643559b2d83b15afde15717a4de1f48a3f8cbf8aa19"} 03:22:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:22:49 INFO - Copying logs to upload dir... 03:22:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:22:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.605895 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-10-22 03:22:49.532320) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 03:22:49.537701) ========= 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.Qx57OnpfSx/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.br8cRswXy4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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/ebfbe9d854efa855e1d3bef548345c499c0445963431e761d6a37a195db49d86061b5251f01658ae065f9cac8749804415ba84b396a88b4a041568747294f9c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8c0e5f44e46c97c79dd4b037fce124b7a986579a98f1950cb61f77c38e77b71ddb73b821aefdebc452854bfbf8c01b84476bbe3a2bbb3aa4a0bd54ba72a07c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfab08cbcb869deb4453404073e2f903090e198c0ba777d0e1a72a11d8d04153ca65994bab453932c9886643559b2d83b15afde15717a4de1f48a3f8cbf8aa19"} build_url:https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/Fgw_pNaLR6WxkHd2ArfvJQ/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/ebfbe9d854efa855e1d3bef548345c499c0445963431e761d6a37a195db49d86061b5251f01658ae065f9cac8749804415ba84b396a88b4a041568747294f9c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8c0e5f44e46c97c79dd4b037fce124b7a986579a98f1950cb61f77c38e77b71ddb73b821aefdebc452854bfbf8c01b84476bbe3a2bbb3aa4a0bd54ba72a07c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfab08cbcb869deb4453404073e2f903090e198c0ba777d0e1a72a11d8d04153ca65994bab453932c9886643559b2d83b15afde15717a4de1f48a3f8cbf8aa19"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 03:22:49.572218) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 03:22:49.572578) ========= 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.Qx57OnpfSx/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.br8cRswXy4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.005138 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 03:22:49.621232) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 03:22:49.621552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 03:22:49.621973) ========= ========= Total master_lag: 0.21 =========