builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0073 starttime: 1486125708.36 results: success (0) buildid: 20170203031608 builduid: 65018f79855140c08672543b442772df revision: 2cdc3dfa46c28a452b2b26199df0e6a2c098544a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:48.356736) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:48.357075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:48.357361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:48.407987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:48.408259) ========= 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.4DR0w2LDuG/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.FEVT5opzjC/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-03 04:41:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 145M=0s 2017-02-03 04:41:48 (145 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162283 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:48.593514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:48.593825) ========= 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.4DR0w2LDuG/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.FEVT5opzjC/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.020389 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:48.645572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 04:41:48.645878) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2cdc3dfa46c28a452b2b26199df0e6a2c098544a --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 2cdc3dfa46c28a452b2b26199df0e6a2c098544a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4DR0w2LDuG/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.FEVT5opzjC/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-03 04:41:48,733 truncating revision to first 12 chars 2017-02-03 04:41:48,733 Setting DEBUG logging. 2017-02-03 04:41:48,734 attempt 1/10 2017-02-03 04:41:48,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2cdc3dfa46c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 04:41:49,731 unpacking tar archive at: mozilla-aurora-2cdc3dfa46c2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.253755 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 04:41:49.925674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:49.925957) ========= script_repo_revision: 2cdc3dfa46c28a452b2b26199df0e6a2c098544a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:49.926704) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:49.926977) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 04:41:49.957148) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-02-03 04:41:49.957427) ========= /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.4DR0w2LDuG/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.FEVT5opzjC/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 04:41:50 INFO - MultiFileLogger online at 20170203 04:41:50 in /builds/slave/test 04:41:50 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 04:41:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:41:50 INFO - {'append_to_log': False, 04:41:50 INFO - 'base_work_dir': '/builds/slave/test', 04:41:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:41:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:41:50 INFO - 'branch': 'Mozilla-Aurora', 04:41:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:41:50 INFO - 'config_files': ('talos/mac_config.py',), 04:41:50 INFO - 'default_actions': ('clobber', 04:41:50 INFO - 'read-buildbot-config', 04:41:50 INFO - 'download-and-extract', 04:41:50 INFO - 'populate-webroot', 04:41:50 INFO - 'create-virtualenv', 04:41:50 INFO - 'install', 04:41:50 INFO - 'run-tests'), 04:41:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:41:50 INFO - 'download_minidump_stackwalk': True, 04:41:50 INFO - 'download_symbols': 'ondemand', 04:41:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:41:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:41:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:41:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:41:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:41:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:41:50 INFO - 'installer_path': 'installer.exe', 04:41:50 INFO - 'log_level': 'info', 04:41:50 INFO - 'log_name': 'talos', 04:41:50 INFO - 'log_to_console': True, 04:41:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:41:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:41:50 INFO - 'opt_config_files': (), 04:41:50 INFO - 'pip_index': False, 04:41:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:41:50 INFO - 'cmd': ('bash', 04:41:50 INFO - '-c', 04:41:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:41:50 INFO - 'enabled': True, 04:41:50 INFO - 'halt_on_failure': False, 04:41:50 INFO - 'name': 'check_screen_resolution'},), 04:41:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:41:50 INFO - 'cmd': ('bash', 04:41:50 INFO - '-c', 04:41:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:41:50 INFO - 'enabled': True, 04:41:50 INFO - 'halt_on_failure': False, 04:41:50 INFO - 'name': 'check_screen_resolution'},), 04:41:50 INFO - 'run_cmd_checks_enabled': True, 04:41:50 INFO - 'sps_profile': False, 04:41:50 INFO - 'sps_profile_interval': 0, 04:41:50 INFO - 'suite': 'dromaeojs-e10s', 04:41:50 INFO - 'system_bits': '32', 04:41:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:41:50 INFO - 'title': 't-yosemite-r7-0073', 04:41:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:41:50 INFO - 'use_talos_json': True, 04:41:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:41:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:41:50 INFO - 'work_dir': 'build'} 04:41:50 INFO - [mozharness: 2017-02-03 12:41:50.170374Z] Running clobber step. 04:41:50 INFO - Running pre-action listener: _resource_record_pre_action 04:41:50 INFO - Running main action method: clobber 04:41:50 INFO - rmtree: /builds/slave/test/build 04:41:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:41:51 INFO - Running post-action listener: _resource_record_post_action 04:41:51 INFO - [mozharness: 2017-02-03 12:41:51.820601Z] Finished clobber step (success) 04:41:51 INFO - [mozharness: 2017-02-03 12:41:51.820750Z] Running read-buildbot-config step. 04:41:51 INFO - Running pre-action listener: _resource_record_pre_action 04:41:51 INFO - Running main action method: read_buildbot_config 04:41:51 INFO - Using buildbot properties: 04:41:51 INFO - { 04:41:51 INFO - "project": "", 04:41:51 INFO - "product": "firefox", 04:41:51 INFO - "script_repo_revision": "production", 04:41:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 04:41:51 INFO - "repository": "", 04:41:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 04:41:51 INFO - "buildid": "20170203031608", 04:41:51 INFO - "pgo_build": "False", 04:41:51 INFO - "basedir": "/builds/slave/test", 04:41:51 INFO - "buildnumber": 49, 04:41:51 INFO - "slavename": "t-yosemite-r7-0073", 04:41:51 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:41:51 INFO - "platform": "yosemite_r7", 04:41:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:41:51 INFO - "branch": "mozilla-aurora", 04:41:51 INFO - "repo_path": "releases/mozilla-aurora", 04:41:51 INFO - "revision": "2cdc3dfa46c28a452b2b26199df0e6a2c098544a", 04:41:51 INFO - "stage_platform": "macosx64", 04:41:51 INFO - "builduid": "65018f79855140c08672543b442772df", 04:41:51 INFO - "slavebuilddir": "test" 04:41:51 INFO - } 04:41:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 04:41:51 INFO - Running post-action listener: _resource_record_post_action 04:41:51 INFO - [mozharness: 2017-02-03 12:41:51.823864Z] Finished read-buildbot-config step (success) 04:41:51 INFO - [mozharness: 2017-02-03 12:41:51.823997Z] Running download-and-extract step. 04:41:51 INFO - Running pre-action listener: _resource_record_pre_action 04:41:51 INFO - Running main action method: download_and_extract 04:41:51 INFO - mkdir: /builds/slave/test/build/tests 04:41:51 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')]} 04:41:51 INFO - trying https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 04:41:51 INFO - Downloading https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 04:41:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 04:41:52 INFO - Downloaded 1199 bytes. 04:41:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 04:41:52 INFO - Using the following test package requirements: 04:41:52 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 04:41:52 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:41:52 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 04:41:52 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:41:52 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 04:41:52 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:41:52 INFO - u'jsshell-mac.zip'], 04:41:52 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:41:52 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 04:41:52 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 04:41:52 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:41:52 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 04:41:52 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:41:52 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 04:41:52 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:41:52 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 04:41:52 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:41:52 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 04:41:52 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:41:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 04:41:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:41:52 INFO - Fetch https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 04:41:53 INFO - Expected file size: 16356113 04:41:53 INFO - Obtained file size: 16356113 04:42:00 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 04:42:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 04:42:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:42:00 INFO - Fetch https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 04:42:01 INFO - Expected file size: 16356113 04:42:01 INFO - Obtained file size: 16356113 04:42:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 04:42:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:42:07 INFO - Fetch https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 04:42:12 INFO - Expected file size: 14403485 04:42:12 INFO - Obtained file size: 14403485 04:42:13 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')]} 04:42:13 INFO - trying https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 04:42:13 INFO - Downloading https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 04:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 04:42:15 INFO - Downloaded 73824779 bytes. 04:42:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 04:42:15 INFO - mkdir: /builds/slave/test/properties 04:42:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:15 INFO - Contents: 04:42:15 INFO - build_url:https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 04:42:24 INFO - Running post-action listener: _resource_record_post_action 04:42:24 INFO - Running post-action listener: set_extra_try_arguments 04:42:24 INFO - [mozharness: 2017-02-03 12:42:24.470038Z] Finished download-and-extract step (success) 04:42:24 INFO - [mozharness: 2017-02-03 12:42:24.470162Z] Running populate-webroot step. 04:42:24 INFO - Running pre-action listener: _resource_record_pre_action 04:42:24 INFO - Running main action method: populate_webroot 04:42:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:24 INFO - '--tppagecycles', 04:42:24 INFO - '7'], 04:42:24 INFO - 'tests': ['tsvgm']}}, 04:42:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:42:24 INFO - 'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:42:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:42:24 INFO - 'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['damp', 'tps']}, 04:42:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:42:24 INFO - 'tests': ['damp', 'tps']}, 04:42:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['dromaeo_dom']}, 04:42:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['basic_compositor_video']}, 04:42:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:42:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['tsvgx', 04:42:24 INFO - 'tsvgr_opacity', 04:42:24 INFO - 'tart', 04:42:24 INFO - 'tscrollx', 04:42:24 INFO - 'cart', 04:42:24 INFO - 'tsvg_static']}, 04:42:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:24 INFO - 'tsvgr_opacity', 04:42:24 INFO - 'tart', 04:42:24 INFO - 'tscrollx', 04:42:24 INFO - 'cart', 04:42:24 INFO - 'tsvg_static']}, 04:42:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:42:24 INFO - 'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['tp5o']}, 04:42:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:42:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:42:24 INFO - 'talos_options': ['--disable-e10s', 04:42:24 INFO - '--xperf_path', 04:42:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:24 INFO - 'tests': ['tp5n']}, 04:42:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:42:24 INFO - 'talos_options': ['--xperf_path', 04:42:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:24 INFO - 'tests': ['tp5n']}}, 04:42:24 INFO - 'talos.zip': {'path': '', 04:42:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:24 INFO - Running post-action listener: _resource_record_post_action 04:42:24 INFO - [mozharness: 2017-02-03 12:42:24.488389Z] Finished populate-webroot step (success) 04:42:24 INFO - [mozharness: 2017-02-03 12:42:24.488522Z] Running create-virtualenv step. 04:42:24 INFO - Running pre-action listener: _resource_record_pre_action 04:42:24 INFO - Running main action method: create_virtualenv 04:42:24 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:24 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 04:42:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:24 INFO - Using real prefix '/tools/python27' 04:42:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:28 INFO - Installing pip.................done. 04:42:28 INFO - Return code: 0 04:42:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:42:28 INFO - Reading from file tmpfile_stdout 04:42:28 INFO - Output received: 04:42:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:42:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc549c7d3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c1d30>, '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 0x1056e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b6be8>, '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.4DR0w2LDuG/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.FEVT5opzjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 04:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:42:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DR0w2LDuG/Render', 04:42:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:28 INFO - 'HOME': '/Users/cltbld', 04:42:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:28 INFO - 'LOGNAME': 'cltbld', 04:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:28 INFO - 'MOZ_NO_REMOTE': '1', 04:42:28 INFO - 'NO_EM_RESTART': '1', 04:42:28 INFO - 'PAGER': '/bin/cat', 04:42:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:28 INFO - 'PWD': '/builds/slave/test', 04:42:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:28 INFO - 'SHELL': '/bin/bash', 04:42:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEVT5opzjC/Listeners', 04:42:28 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:42:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:28 INFO - 'USER': 'cltbld', 04:42:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:28 INFO - 'XPC_FLAGS': '0x0', 04:42:28 INFO - 'XPC_SERVICE_NAME': '0', 04:42:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:28 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 04:42:28 INFO - Cleaning up... 04:42:28 INFO - Return code: 0 04:42:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1059e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc549c7d3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c1d30>, '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 0x1056e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b6be8>, '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.4DR0w2LDuG/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.FEVT5opzjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 04:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:42:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DR0w2LDuG/Render', 04:42:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:28 INFO - 'HOME': '/Users/cltbld', 04:42:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:28 INFO - 'LOGNAME': 'cltbld', 04:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:28 INFO - 'MOZ_NO_REMOTE': '1', 04:42:28 INFO - 'NO_EM_RESTART': '1', 04:42:28 INFO - 'PAGER': '/bin/cat', 04:42:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:28 INFO - 'PWD': '/builds/slave/test', 04:42:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:28 INFO - 'SHELL': '/bin/bash', 04:42:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEVT5opzjC/Listeners', 04:42:28 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:42:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:28 INFO - 'USER': 'cltbld', 04:42:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:28 INFO - 'XPC_FLAGS': '0x0', 04:42:28 INFO - 'XPC_SERVICE_NAME': '0', 04:42:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:28 INFO - Downloading/unpacking psutil>=3.1.1 04:42:28 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 04:42:28 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 04:42:28 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 04:42:28 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 04:42:28 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 04:42:28 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 04:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:32 INFO - Installing collected packages: psutil 04:42:32 INFO - Running setup.py install for psutil 04:42:32 INFO - building 'psutil._psutil_osx' extension 04:42:32 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 04:42:33 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 04:42:33 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 04:42:33 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 04:42:33 INFO - building 'psutil._psutil_posix' extension 04:42:33 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 04:42:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:42:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:42:33 INFO - ^ 04:42:33 INFO - 1 warning generated. 04:42:33 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 04:42:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:33 INFO - Successfully installed psutil 04:42:33 INFO - Cleaning up... 04:42:33 INFO - Return code: 0 04:42:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:33 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 0x1059e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc549c7d3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c1d30>, '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 0x1056e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b6be8>, '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.4DR0w2LDuG/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.FEVT5opzjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 04:42:33 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 04:42:33 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 04:42:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DR0w2LDuG/Render', 04:42:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:33 INFO - 'HOME': '/Users/cltbld', 04:42:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:33 INFO - 'LOGNAME': 'cltbld', 04:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:33 INFO - 'MOZ_NO_REMOTE': '1', 04:42:33 INFO - 'NO_EM_RESTART': '1', 04:42:33 INFO - 'PAGER': '/bin/cat', 04:42:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:33 INFO - 'PWD': '/builds/slave/test', 04:42:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:33 INFO - 'SHELL': '/bin/bash', 04:42:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEVT5opzjC/Listeners', 04:42:33 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:42:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:33 INFO - 'USER': 'cltbld', 04:42:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:33 INFO - 'XPC_FLAGS': '0x0', 04:42:33 INFO - 'XPC_SERVICE_NAME': '0', 04:42:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:42:34 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 04:42:34 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 04:42:34 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 04:42:34 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 04:42:34 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 04:42:34 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 04:42:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:42:36 INFO - Installing collected packages: mozsystemmonitor 04:42:36 INFO - Running setup.py install for mozsystemmonitor 04:42:36 INFO - Successfully installed mozsystemmonitor 04:42:36 INFO - Cleaning up... 04:42:36 INFO - Return code: 0 04:42:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:36 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 0x1059e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc549c7d3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c1d30>, '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 0x1056e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b6be8>, '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.4DR0w2LDuG/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.FEVT5opzjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 04:42:36 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 04:42:36 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 04:42:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DR0w2LDuG/Render', 04:42:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:36 INFO - 'HOME': '/Users/cltbld', 04:42:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:36 INFO - 'LOGNAME': 'cltbld', 04:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:36 INFO - 'MOZ_NO_REMOTE': '1', 04:42:36 INFO - 'NO_EM_RESTART': '1', 04:42:36 INFO - 'PAGER': '/bin/cat', 04:42:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:36 INFO - 'PWD': '/builds/slave/test', 04:42:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:36 INFO - 'SHELL': '/bin/bash', 04:42:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEVT5opzjC/Listeners', 04:42:36 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:42:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:36 INFO - 'USER': 'cltbld', 04:42:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:36 INFO - 'XPC_FLAGS': '0x0', 04:42:36 INFO - 'XPC_SERVICE_NAME': '0', 04:42:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:37 INFO - Downloading/unpacking jsonschema==2.5.1 04:42:37 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 04:42:37 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 04:42:37 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 04:42:37 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 04:42:37 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 04:42:37 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 04:42:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:42:40 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 04:42:40 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 04:42:40 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 04:42:40 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 04:42:40 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 04:42:40 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 04:42:40 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:40 INFO - warning: no files found matching '*.txt' 04:42:40 INFO - no previously-included directories found matching 'build' 04:42:40 INFO - no previously-included directories found matching 'dist' 04:42:40 INFO - no previously-included directories found matching '.git*' 04:42:40 INFO - Installing collected packages: jsonschema, functools32 04:42:40 INFO - Running setup.py install for functools32 04:42:40 INFO - warning: no files found matching '*.txt' 04:42:40 INFO - no previously-included directories found matching 'build' 04:42:40 INFO - no previously-included directories found matching 'dist' 04:42:40 INFO - no previously-included directories found matching '.git*' 04:42:40 INFO - Successfully installed jsonschema functools32 04:42:40 INFO - Cleaning up... 04:42:41 INFO - Return code: 0 04:42:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1059e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc549c7d3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c1d30>, '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 0x1056e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b6be8>, '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.4DR0w2LDuG/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.FEVT5opzjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 04:42:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:42:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:42:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DR0w2LDuG/Render', 04:42:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:41 INFO - 'HOME': '/Users/cltbld', 04:42:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:41 INFO - 'LOGNAME': 'cltbld', 04:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:41 INFO - 'MOZ_NO_REMOTE': '1', 04:42:41 INFO - 'NO_EM_RESTART': '1', 04:42:41 INFO - 'PAGER': '/bin/cat', 04:42:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:41 INFO - 'PWD': '/builds/slave/test', 04:42:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:41 INFO - 'SHELL': '/bin/bash', 04:42:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEVT5opzjC/Listeners', 04:42:41 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:42:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:41 INFO - 'USER': 'cltbld', 04:42:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:41 INFO - 'XPC_FLAGS': '0x0', 04:42:41 INFO - 'XPC_SERVICE_NAME': '0', 04:42:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:42:41 INFO - Cleaning up... 04:42:41 INFO - Return code: 0 04:42:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1059e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc549c7d3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c1d30>, '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 0x1056e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b6be8>, '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.4DR0w2LDuG/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.FEVT5opzjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 04:42:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:42:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:42:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DR0w2LDuG/Render', 04:42:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:41 INFO - 'HOME': '/Users/cltbld', 04:42:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:41 INFO - 'LOGNAME': 'cltbld', 04:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:41 INFO - 'MOZ_NO_REMOTE': '1', 04:42:41 INFO - 'NO_EM_RESTART': '1', 04:42:41 INFO - 'PAGER': '/bin/cat', 04:42:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:41 INFO - 'PWD': '/builds/slave/test', 04:42:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:41 INFO - 'SHELL': '/bin/bash', 04:42:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEVT5opzjC/Listeners', 04:42:41 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:42:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:41 INFO - 'USER': 'cltbld', 04:42:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:41 INFO - 'XPC_FLAGS': '0x0', 04:42:41 INFO - 'XPC_SERVICE_NAME': '0', 04:42:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:41 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 04:42:41 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 04:42:41 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 04:42:41 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 04:42:41 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 04:42:41 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 04:42:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:45 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 04:42:45 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 04:42:45 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 04:42:45 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 04:42:45 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 04:42:45 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 04:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:46 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 04:42:46 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 04:42:46 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 04:42:46 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 04:42:46 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 04:42:46 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 04:42:46 INFO - Downloading docopt-0.6.1.tar.gz 04:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:46 INFO - Running setup.py install for blobuploader 04:42:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:47 INFO - Running setup.py install for requests 04:42:47 INFO - Running setup.py install for docopt 04:42:47 INFO - Successfully installed blobuploader requests docopt 04:42:47 INFO - Cleaning up... 04:42:47 INFO - Return code: 0 04:42:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:47 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')]} 04:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:47 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')]} 04:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:47 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 0x1059e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc549c7d3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c1d30>, '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 0x1056e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b6be8>, '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.4DR0w2LDuG/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.FEVT5opzjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 04:42:47 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 04:42:47 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 04:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DR0w2LDuG/Render', 04:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:47 INFO - 'HOME': '/Users/cltbld', 04:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:47 INFO - 'LOGNAME': 'cltbld', 04:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:47 INFO - 'MOZ_NO_REMOTE': '1', 04:42:47 INFO - 'NO_EM_RESTART': '1', 04:42:47 INFO - 'PAGER': '/bin/cat', 04:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:47 INFO - 'PWD': '/builds/slave/test', 04:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:47 INFO - 'SHELL': '/bin/bash', 04:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEVT5opzjC/Listeners', 04:42:47 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:47 INFO - 'USER': 'cltbld', 04:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:47 INFO - 'XPC_FLAGS': '0x0', 04:42:47 INFO - 'XPC_SERVICE_NAME': '0', 04:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:48 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-R_mX8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:48 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-gENThk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:48 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-8qo6GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:48 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-utPjOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:48 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ZpSxM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:48 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-2MRLe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:48 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-G1Zr7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:48 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-zk5Qzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:48 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-o1DcHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:49 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-SHZ9fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:49 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ytIHyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:49 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-hf_Mwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:49 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-lskOsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:49 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-YNQhtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:49 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-a_rHwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:49 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-XsvyMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:49 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ok9NgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:49 INFO - Running setup.py install for manifestparser 04:42:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:42:49 INFO - Running setup.py install for mozcrash 04:42:50 INFO - Running setup.py install for mozdebug 04:42:50 INFO - Running setup.py install for mozdevice 04:42:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:42:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:42:50 INFO - Running setup.py install for mozfile 04:42:50 INFO - Running setup.py install for mozhttpd 04:42:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:42:50 INFO - Running setup.py install for mozinfo 04:42:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:42:50 INFO - Running setup.py install for mozInstall 04:42:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:42:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:42:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:42:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:42:51 INFO - Running setup.py install for mozleak 04:42:51 INFO - Running setup.py install for mozlog 04:42:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:42:51 INFO - Running setup.py install for moznetwork 04:42:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:42:51 INFO - Running setup.py install for mozprocess 04:42:51 INFO - Running setup.py install for mozprofile 04:42:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:42:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:42:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:42:51 INFO - Running setup.py install for mozrunner 04:42:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:42:51 INFO - Running setup.py install for mozscreenshot 04:42:52 INFO - Running setup.py install for moztest 04:42:52 INFO - Running setup.py install for mozversion 04:42:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:42:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:42:52 INFO - Cleaning up... 04:42:52 INFO - Return code: 0 04:42:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:52 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 0x1059e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc549c7d3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c1d30>, '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 0x1056e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b6be8>, '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.4DR0w2LDuG/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.FEVT5opzjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 04:42:52 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 04:42:52 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 04:42:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DR0w2LDuG/Render', 04:42:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:52 INFO - 'HOME': '/Users/cltbld', 04:42:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:52 INFO - 'LOGNAME': 'cltbld', 04:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:52 INFO - 'MOZ_NO_REMOTE': '1', 04:42:52 INFO - 'NO_EM_RESTART': '1', 04:42:52 INFO - 'PAGER': '/bin/cat', 04:42:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:52 INFO - 'PWD': '/builds/slave/test', 04:42:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:52 INFO - 'SHELL': '/bin/bash', 04:42:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEVT5opzjC/Listeners', 04:42:52 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:42:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:52 INFO - 'USER': 'cltbld', 04:42:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:52 INFO - 'XPC_FLAGS': '0x0', 04:42:52 INFO - 'XPC_SERVICE_NAME': '0', 04:42:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:52 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-muObD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:52 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)) 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:52 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-RzEyPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:52 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-LAf5az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:53 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)) 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:53 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-qZRlfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:53 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-uvPSnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:53 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)) 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:53 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-lJb_tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:53 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)) 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:53 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-BxVkZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:53 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)) 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:53 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ehjdwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:53 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)) 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:53 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-rHNk89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:53 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)) 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:53 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-5AbFkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:53 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)) 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:53 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-UhknSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:53 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)) 04:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:53 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-FXedtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:54 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-f4hisg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:54 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)) 04:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:54 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-1xhD4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:54 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-To5t83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:54 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)) 04:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:54 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-qzqwdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:54 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-fC6bhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:54 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)) 04:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:42:54 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)) 04:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:54 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 04:42:54 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 04:42:54 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 04:42:54 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 04:42:54 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 04:42:54 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 04:42:57 INFO - Downloading blessings-1.6.tar.gz 04:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:42:58 INFO - Installing collected packages: blessings 04:42:58 INFO - Running setup.py install for blessings 04:42:58 INFO - Successfully installed blessings 04:42:58 INFO - Cleaning up... 04:42:58 INFO - Return code: 0 04:42:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:58 INFO - Reading from file tmpfile_stdout 04:42:58 INFO - Current package versions: 04:42:58 INFO - blessings == 1.6 04:42:58 INFO - blobuploader == 1.2.4 04:42:58 INFO - docopt == 0.6.1 04:42:58 INFO - functools32 == 3.2.3-2 04:42:58 INFO - jsonschema == 2.5.1 04:42:58 INFO - manifestparser == 1.1 04:42:58 INFO - mozInstall == 1.12 04:42:58 INFO - mozcrash == 1.0 04:42:58 INFO - mozdebug == 0.1 04:42:58 INFO - mozdevice == 0.49 04:42:58 INFO - mozfile == 1.2 04:42:58 INFO - mozhttpd == 0.7 04:42:58 INFO - mozinfo == 0.9 04:42:58 INFO - mozleak == 0.1 04:42:58 INFO - mozlog == 3.4 04:42:58 INFO - moznetwork == 0.27 04:42:58 INFO - mozprocess == 0.24 04:42:58 INFO - mozprofile == 0.28 04:42:58 INFO - mozrunner == 6.13 04:42:58 INFO - mozscreenshot == 0.1 04:42:58 INFO - mozsystemmonitor == 0.3 04:42:58 INFO - moztest == 0.8 04:42:58 INFO - mozversion == 1.4 04:42:58 INFO - psutil == 3.1.1 04:42:58 INFO - requests == 1.2.3 04:42:58 INFO - wsgiref == 0.1.2 04:42:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:58 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')]} 04:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:58 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')]} 04:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:58 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 0x1059e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc549c7d3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c1d30>, '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 0x1056e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b6be8>, '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.4DR0w2LDuG/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.FEVT5opzjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 04:42:58 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 04:42:58 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 04:42:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DR0w2LDuG/Render', 04:42:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:58 INFO - 'HOME': '/Users/cltbld', 04:42:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:58 INFO - 'LOGNAME': 'cltbld', 04:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:58 INFO - 'MOZ_NO_REMOTE': '1', 04:42:58 INFO - 'NO_EM_RESTART': '1', 04:42:58 INFO - 'PAGER': '/bin/cat', 04:42:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:58 INFO - 'PWD': '/builds/slave/test', 04:42:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:58 INFO - 'SHELL': '/bin/bash', 04:42:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEVT5opzjC/Listeners', 04:42:58 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:42:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:58 INFO - 'USER': 'cltbld', 04:42:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:58 INFO - 'XPC_FLAGS': '0x0', 04:42:58 INFO - 'XPC_SERVICE_NAME': '0', 04:42:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:58 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)) 04:42:58 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)) 04:42:58 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)) 04:42:58 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)) 04:42:58 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)) 04:42:58 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)) 04:42:58 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)) 04:42:58 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)) 04:42:58 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)) 04:42:58 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)) 04:42:58 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)) 04:42:58 INFO - Cleaning up... 04:42:58 INFO - Return code: 0 04:42:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:42:58 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')]} 04:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:58 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')]} 04:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:58 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 0x1059e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc549c7d3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c1d30>, '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 0x1056e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b6be8>, '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.4DR0w2LDuG/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.FEVT5opzjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 04:42:58 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 04:42:58 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 04:42:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DR0w2LDuG/Render', 04:42:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:58 INFO - 'HOME': '/Users/cltbld', 04:42:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:58 INFO - 'LOGNAME': 'cltbld', 04:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:58 INFO - 'MOZ_NO_REMOTE': '1', 04:42:58 INFO - 'NO_EM_RESTART': '1', 04:42:58 INFO - 'PAGER': '/bin/cat', 04:42:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:58 INFO - 'PWD': '/builds/slave/test', 04:42:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:58 INFO - 'SHELL': '/bin/bash', 04:42:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEVT5opzjC/Listeners', 04:42:58 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:42:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:58 INFO - 'USER': 'cltbld', 04:42:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:58 INFO - 'XPC_FLAGS': '0x0', 04:42:58 INFO - 'XPC_SERVICE_NAME': '0', 04:42:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:42:59 INFO - Cleaning up... 04:42:59 INFO - Return code: 0 04:42:59 INFO - Running post-action listener: _resource_record_post_action 04:42:59 INFO - Running post-action listener: _start_resource_monitoring 04:42:59 INFO - Starting resource monitoring. 04:42:59 INFO - [mozharness: 2017-02-03 12:42:59.242687Z] Finished create-virtualenv step (success) 04:42:59 INFO - [mozharness: 2017-02-03 12:42:59.243758Z] Running install step. 04:42:59 INFO - Running pre-action listener: _resource_record_pre_action 04:42:59 INFO - Running main action method: install 04:42:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:59 INFO - Reading from file tmpfile_stdout 04:42:59 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:42:59 INFO - Reading from file tmpfile_stdout 04:42:59 INFO - Output received: 04:42:59 INFO - Usage: mozinstall [options] installer 04:42:59 INFO - Options: 04:42:59 INFO - -h, --help show this help message and exit 04:42:59 INFO - -d DEST, --destination=DEST 04:42:59 INFO - Directory to install application into. [default: 04:42:59 INFO - "/builds/slave/test"] 04:42:59 INFO - --app=APP Application being installed. [default: firefox] 04:42:59 INFO - mkdir: /builds/slave/test/build/application 04:42:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 04:43:19 INFO - Reading from file tmpfile_stdout 04:43:19 INFO - Output received: 04:43:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:43:19 INFO - Running post-action listener: _resource_record_post_action 04:43:19 INFO - [mozharness: 2017-02-03 12:43:19.481031Z] Finished install step (success) 04:43:19 INFO - [mozharness: 2017-02-03 12:43:19.481187Z] Running run-tests step. 04:43:19 INFO - Running pre-action listener: _resource_record_pre_action 04:43:19 INFO - Running main action method: run_tests 04:43:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:43:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:43:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:43:19 INFO - 2017-02-03 04:43:19.496 screenresolution[3900:155868] starting screenresolution argv=screenresolution get 04:43:19 INFO - 2017-02-03 04:43:19.498 screenresolution[3900:155868] Display 0: 1600x1200x32@60 04:43:19 INFO - 2017-02-03 04:43:19.504 screenresolution[3901:155871] starting screenresolution argv=screenresolution list 04:43:19 INFO - Available Modes on Display 0 04:43:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:43:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:43:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:43:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:43:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:43:19 INFO - Intel Iris: 04:43:19 INFO - Chipset Model: Intel Iris 04:43:19 INFO - Type: GPU 04:43:19 INFO - Bus: Built-In 04:43:19 INFO - VRAM (Dynamic, Max): 1536 MB 04:43:19 INFO - Vendor: Intel (0x8086) 04:43:19 INFO - Device ID: 0x0a2e 04:43:19 INFO - Revision ID: 0x0009 04:43:19 INFO - Displays: 04:43:19 INFO - Display: 04:43:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:43:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:43:19 INFO - Display Serial Number: 1600x1200 60 04:43:19 INFO - Main Display: Yes 04:43:19 INFO - Mirror: Off 04:43:19 INFO - Online: Yes 04:43:19 INFO - Rotation: Supported 04:43:19 INFO - Return code: 0 04:43:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:43:19 INFO - Python 2.7.3 04:43:19 INFO - Return code: 0 04:43:19 INFO - grabbing minidump binary from tooltool 04:43: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')]} 04:43:19 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 0x1057c1d30>, '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 0x1056e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:43:19 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 04:43:19 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 04:43:19 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 04:43:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:19 INFO - Return code: 0 04:43:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:43:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:43:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:43:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:43:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:43:19 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/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 04:43:19 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/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0073 --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 04:43:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4DR0w2LDuG/Render', 04:43:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:19 INFO - 'HOME': '/Users/cltbld', 04:43:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:19 INFO - 'LOGNAME': 'cltbld', 04:43:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:43:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:19 INFO - 'MOZ_NO_REMOTE': '1', 04:43:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:43:19 INFO - 'NO_EM_RESTART': '1', 04:43:19 INFO - 'PAGER': '/bin/cat', 04:43:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:19 INFO - 'PWD': '/builds/slave/test', 04:43:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:43:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:19 INFO - 'SHELL': '/bin/bash', 04:43:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FEVT5opzjC/Listeners', 04:43:19 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 04:43:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:19 INFO - 'USER': 'cltbld', 04:43:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:19 INFO - 'XPC_FLAGS': '0x0', 04:43:19 INFO - 'XPC_SERVICE_NAME': '0', 04:43:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:19 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/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 04:43:20 INFO - mozversion application_buildid: 20170203031608 04:43:20 INFO - mozversion application_changeset: 2cdc3dfa46c28a452b2b26199df0e6a2c098544a 04:43:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:43:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:20 INFO - mozversion application_name: Firefox 04:43:20 INFO - mozversion application_remotingname: firefox-dev 04:43:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:43:20 INFO - mozversion application_vendor: Mozilla 04:43:20 INFO - mozversion application_version: 53.0a2 04:43:20 INFO - mozversion platform_buildid: 20170203031608 04:43:20 INFO - mozversion platform_changeset: 2cdc3dfa46c28a452b2b26199df0e6a2c098544a 04:43:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:43:20 INFO - mozversion platform_version: 53.0a2 04:43:20 INFO - using testdate: 1486125800 04:43:20 INFO - actual date: 1486125800 04:43:20 INFO - starting webserver on 'localhost:56782' 04:43:20 INFO - SUITE-START | Running 2 tests 04:43:20 INFO - TEST-START | dromaeo_css 04:43:20 INFO - operating with platform_type : mac_ 04:43:20 INFO - Initialising browser for dromaeo_css test... 04:43:20 INFO - TEST-INFO | started process 3911 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpfZTAKt/profile http://localhost:56782/getInfo.html) 04:43:22 INFO - PROCESS | 3911 | 2017-02-03 04:43:22.847 plugin-container[3913:156034] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 04:43:22 INFO - PROCESS | 3911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:22 INFO - PROCESS | 3911 | 2017-02-03 04:43:22.850 plugin-container[3913:156034] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 04:43:22 INFO - PROCESS | 3911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:22 INFO - PROCESS | 3911 | 2017-02-03 04:43:22.851 plugin-container[3913:156034] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:43:22 INFO - PROCESS | 3911 | __metrics Screen width/height:1600/1200 04:43:22 INFO - PROCESS | 3911 | colorDepth:24 04:43:22 INFO - PROCESS | 3911 | Browser inner width/height: 1024/689 04:43:22 INFO - PROCESS | 3911 | __metrics 04:43:23 ERROR - PROCESS | 3911 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 04:43:23 INFO - TEST-INFO | 3911: exit 0 04:43:23 INFO - Browser initialized. 04:43:23 INFO - Running cycle 1/1 for dromaeo_css test... 04:43:23 INFO - TEST-INFO | started process 3914 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpfZTAKt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:26 INFO - PROCESS | 3914 | 2017-02-03 04:43:26.108 plugin-container[3915:156161] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 04:43:26 INFO - PROCESS | 3914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:26 INFO - PROCESS | 3914 | 2017-02-03 04:43:26.109 plugin-container[3915:156161] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 04:43:26 INFO - PROCESS | 3914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:26 INFO - PROCESS | 3914 | 2017-02-03 04:43:26.109 plugin-container[3915:156161] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:43:35 INFO - PROCESS | 3914 | RSS: Main: 218722304 04:43:35 INFO - PROCESS | 3914 | 04:46:37 INFO - PROCESS | 3914 | Cycle 1(1): loaded http://localhost:56782/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56782/tests/dromaeo/cssquery-ext.html) 04:46:39 INFO - PROCESS | 3914 | RSS: Main: 235868160 04:46:39 INFO - PROCESS | 3914 | 04:48:24 INFO - PROCESS | 3914 | ************************* 04:48:24 INFO - PROCESS | 3914 | A coding exception was thrown and uncaught in a Task. 04:48:24 INFO - PROCESS | 3914 | 04:48:24 ERROR - PROCESS | 3914 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:24 INFO - PROCESS | 3914 | Full stack: 04:48:24 INFO - PROCESS | 3914 | ************************* 04:49:41 INFO - PROCESS | 3914 | Cycle 1(1): loaded http://localhost:56782/tests/dromaeo/cssquery-ext.html (next: http://localhost:56782/tests/dromaeo/cssquery-jquery.html) 04:49:42 INFO - PROCESS | 3914 | RSS: Main: 248762368 04:49:42 INFO - PROCESS | 3914 | 04:52:44 INFO - PROCESS | 3914 | Cycle 1(1): loaded http://localhost:56782/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56782/tests/dromaeo/cssquery-mootools.html) 04:52:44 INFO - PROCESS | 3914 | RSS: Main: 255254528 04:52:44 INFO - PROCESS | 3914 | 04:55:46 INFO - PROCESS | 3914 | Cycle 1(1): loaded http://localhost:56782/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56782/tests/dromaeo/cssquery-prototype.html) 04:55:47 INFO - PROCESS | 3914 | RSS: Main: 251645952 04:55:47 INFO - PROCESS | 3914 | 04:58:50 INFO - PROCESS | 3914 | Cycle 1(1): loaded http://localhost:56782/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56782/tests/dromaeo/cssquery-yui.html) 04:58:50 INFO - PROCESS | 3914 | RSS: Main: 255746048 04:58:50 INFO - PROCESS | 3914 | 05:01:53 INFO - PROCESS | 3914 | Cycle 1(1): loaded http://localhost:56782/tests/dromaeo/cssquery-yui.html (next: http://localhost:56782/tests/dromaeo/cssquery-dojo.html) 05:01:53 INFO - PROCESS | 3914 | RSS: Main: 256856064 05:01:53 INFO - PROCESS | 3914 | 05:01:53 INFO - PROCESS | 3914 | __start_tp_report 05:01:53 INFO - PROCESS | 3914 | _x_x_mozilla_page_load 05:01:53 INFO - PROCESS | 3914 | _x_x_mozilla_page_load_details 05:01:53 INFO - PROCESS | 3914 | |i|pagename|runs| 05:01:53 INFO - PROCESS | 3914 | |0;dojo.html;2809.19937817722;2809.5083360411923;3015.381846721422;3364.44486659701;3421.5723034620673;4464.017916058466;5374.89250214996;5762.913556296654;5807.274090738658;5810.3899090595405;4712.670113092085;5747.59766816323;5771.653700777956;5784.074548072309;5799.797007104752;5250.343707036621;5283.8150664726745;5314.096603577401;5319.308489896308;5324.520793128618;5278.9208161877605;5328.014317351302;5328.8401347959625;5330.493603107699;5338.332708411449;4283.464566929134;5147.202183661539;5325.627206095575;5328;5361.571074314045;4256.340267258564;5268.104422248189;5269.235960785664;5304.469553044703;5332.76002579881;5210.817621383233;5215.895682086375;5247.816326428557;5253.684778913277;5258.789648414059;5595.776168953237;5742.483176514092;5772.624779389326;5858.179854820329;5858.853528661817;6054.96972515139;6146.815595532141;6152.3540028297275;6176.135341052256;6238.251409830804;6288.748450061992;6292.370762923671;6293.244810622708;6319.24169099711;6325.05124231369;5810.1865738796605;5816.12758086282;5833.766649334021;5846.210761547137;5857.648541087506;6212.1303017577575;6225.688715564203;6230.470410015108;6278.340774218641;6278.46633036197;6127.111568822495;6213.5339849511465;6227.159333489921;6227.470664993436;6230.501559875199;6253.624782513064;6307.842303942346;6314.526410519229;6321.620702757849;6322.272938612026;5606.719664016783;6132.50939924805;6174.598651087665;6178.907316390258;6303.117563541108;5451.291332126798;5618.735784448467;5904.321003084614;6011.609245399122;6043.700604370081;4538.72767633943;4907.631927605373;5005.374328208974;5015.322931404214;5033.345665063592;4294.892627684333;4335.414719012893;4391.5827996340295;4442.644588432918;4463.308187230984;5556.472135147154;5592.133219351007;5644.955683198621;5645.012122878562;5682.289713785777;5043.394792624908;6070.666113363807;6109.175261339751;6127.417895299939;6144.846378840475;4659.743714095689;4869.780859861315;5658.405867383865;5869.589128760946;5869.735861886225;5506.697131657797;5516.558675305966;5519.448055194448;5523.199136125239;5524;6272.498200143978;6296.087067375205;6300.9684951574945;6311.747530098928;6351.777687780906;5068.6451948363265;6178.969105154445;6211.378862113933;6231.2522497300615;6290.370962903673;6238.376162383907;6270;6316.11574379578;6317.557770955989;6323.114763933145;5230.8169214077325;6176.60286842226;6262.966610509215;6265.154204182377;6267.2165979252595;5240.371155461369;5857.0043092673495;6207.441330280297;6330.968345158245;6349.49204063683;6129.601575897553;6144.064619644798;6157.32269450369;6176.505879529716;6185.474234689922;6104.816855494342;6176.413240742122;6177.444030037318;6208.565400421927;6223.097650840693;5804.709764511842;5844.620099693507;5994.10088486713;6034.125051867542;6064.7175900754855;6028.969855150696;6095.146679464967;6116.418940200674;6141.36327073057;6194.628322300677;5996.400359963969;5997.370276121119;5999.3100793407575;6012.128241405059;6030.4572588467245 05:01:53 INFO - PROCESS | 3914 | |1;ext.html;449.4067830463789;483.57928602116164;491.7295487481884;508.6236185222936;511.11832089645367;39129.608703912985;41737.3739393909;41757.58242417575;44131;44393.55606443935;43487;43496;43579.56420435795;43702.7814860926;43795.78102109493;9279.999999999984;9510.38182518134;9514.80970380592;9521.381110227847;11016.449177541132;11026.228164028522;11212.159088068387;11287.943560282187;11302.265352752085;11336.036436902874;11199.720006999809;11268.718282042973;11308.660740177807;11322.773544529146;11333.829992550118;11237.438128093603;11263.493142808593;11290.040346570551;11314.208005439581;11315.717107072307;10995.945020274927;11002.394868282241;11042.116630669527;11055.336679799157;11059.336439813636;36754;37084.44373334402;37147.257054858754;37209.813950930344;37239.813800930824;3913.7847418391975;3937.3700207966876;3970.9007274818073;3983.2630963271886;4009.518857737061;27694.44611107787;28799.856000720072;28820.135395938156;29541.70458295411;29594;3216.662250463691;3242.8702851885896;3259.2014956335847;3265.0694552052787;3329.6170940341926;494357;494604;496513.55229671585;497726;499285;56991.14513282304;57256.71371643115;57350.7132464335;57387;57493.71253143708;59820.10269845956;59897;60037;60397;60492.69753651204;16009.27958241882;16071.35714571404;16210.027398356136;16228.918855405884;16289.918550407408;10965.287256328313;11378.715532111597;11655.650330490098;12484.875151248552;12693.238405695687;14623.415063397344;14643.707125857423;17697.203625836868;17976.370827021252;18066.458006259832;6710.798676039629;7779.57212353326;7938.166492518202;7940.3548923879025;7958.164392738795;863.6156910175038;882.4220135811054;885.7298523950257;898.9325800564984;918.7151982885327;23844.16545420902;26397.340066498105;27665.308367290978;30523.69476305253;30618;1069.7165251208437;1075.9246852720391;1084.7613525024483;1086.4296244471557;1214.489914236023;13725.382357793924;14213.289335533182;15202.9357944945;15564.533064008097;15588.454404095803;665463;667439;667481;670681;673341;53160;53527.73236133794;53556.73221633867;53720.194197087076;53769.73115134478;1419.425132821209;1429.7855321701827;1431.3701971132668;1435.0743770268118;1453.5130731204954;27900.720992790626;28157;28985.56521652219;29060.27349316284;29074.854625726737;45255.32117018313;45456.863578410805;45963.850903727674;46010.76994615005;46259;592965;596598;598772;600016;600815;24213.394665133514;25116;34989;35665.28669426649;37625.81187094047;41252.793736031126;42377;42542.5745742551;43509;44212.11575768531;35378.29243415066;35763;36222;36285.63714362823;36360.09099772421;35672.108197295274;35693;35874;36215.81892090523;36597;33892.661073389936;34383.656163439045;34684.959451216506;35022.29955400827;35357.116072098404;29284.853575731984;31250;31342;31405;31480.37039259248;23357.532849343257;23461.41346466352;23792.643110353012;23828.642570361804;23861 05:01:53 INFO - PROCESS | 3914 | |2;jquery.html;388.22161566060043;391.92553414851193;400.85769551809096;404.48832227232555;412.8049297284362;16327.755083673725;19903.1043603038;21205.939703014865;21223;21290.254841080565;20866.68699969498;21275;21295.68056479154;21369.358919232447;21623;5501.9174712379245;5906.586538942276;5950.97024514879;6005.12925625784;6041.546883983697;5866.149408335788;5890.587658863881;5966.075258334943;5986.371430999748;6000.879982400371;5657.66054036757;5841.824745257649;5877.441643043904;5882.3529411764675;5897.056470964647;5000.924986125211;5624.325080990287;5837;5851.590388672795;5866.530677545786;5151.4333423323405;5185.248139019821;5189.818356357547;5191.351081114861;5197.350331208599;25175.49649007028;25229;25255.116070937613;25392.49215015708;25478.10826621078;3140.3248301615035;3154.148379937427;3169.635491918436;3173.5715678383353;3188.8246146461934;12577;15558.533244002698;15595.986260893005;15894.364225430969;16079.437219697254;1810.520212143783;1846.4276074416973;1849.3712137873054;1852.3516769130697;1856.712209607513;96989;116373;122957.38521307426;124054;128041.35979320137;11431.485583148778;11629.651110466699;11710.063194944383;11724.88275117238;11725.765484690259;14527.636809079857;14543.92728036353;14544.709105818036;14547.27263636814;14615.26923653813;8566.78583035429;8696.956515217384;8782.165694259164;8898.55507224649;8920.73237802867;8689.913100869036;8785.385023048326;8788.824223515621;8918.687845925362;8962.507062111516;7095.077639906779;7241.674124664298;7255.23819998903;7275.345218930322;7275.67259473325;1659.8838081334432;1673.5314112048645;1917.6260629177455;1974.960500789976;1978.920843166286;1033.338663255517;1037.8910214427376;1044.498640652491;1047.068109382635;1056.4559251985233;17055.147242638068;21148.15407383718;21174.364769056952;21461.141554337963;21540.676889846665;959.29971121082;990.1286867556504;1018.9592416303414;1030.8041472120274;1063.7925604507047;11146.219764616399;11419.657410277705;11430.885691142983;11438.9704926557;11445.370504622326;652635;722575;727963;731173;734657;96307.9552097847;117145;120256;126979;127315.36342318414;993.6621548673486;1058.5183741397645;1097.7694684116266;1107.4628805029554;1111.5331560744507;19364.806351936862;19798.703019455006;20000.49998750043;20040.69938950946;20072.899635502312;61370;61819.07271390843;62314;62422.063669044095;62941.933681258626;88080;89663.10336896547;90791.09208907826;91082;91985.5400722992;7883.172266912121;7889.171636978264;7909.367250620052;8101;8154.633041513028;11350.432478375884;11741.706457338634;12046.9760070395;12245.510179593073;12831.615051548468;8540.487570745776;8780.517071561126;10071.647492337734;10737.624183153552;11080.445977701243;9339.439633621732;9869.654562090293;10417.84373234387;10741.281394977079;11135.832962505407;10929.836052459379;10950.835737463785;11190.272632278877;11269.985701286923;11309.038731707897;7947.8807817881625;8005.759827205193;8114.026316842017;8276.958615206886;8427.705030323908;7966.083900351534;10138.797224055625;10997.835032474359;10998.34009959405;11133.498992545194 05:01:53 INFO - PROCESS | 3914 | |3;mootools.html;1253.2417887178258;1428.7785393264048;1455.803466532018;1456.410153887676;1476.7194233095715;7519.924800751991;7769.261920117579;8100.108988011321;8568.614412351444;8579.957100214506;7990.720324788634;8226.712065077723;8288.502689838613;8386.91613083869;8393.83212335753;2277.817774578034;2317.7798109179685;2322.8722420266877;2325.534893021394;2334.579775640384;2100.9369718908456;2179.095675294751;2314.201600447843;2351.235848349285;2364.3970787449175;2254.4701995031155;2334.6381310896836;2344.2146880794953;2345.976540234593;2347.295811256625;2299.034405549665;2302.3783578433895;2318.7333456652364;2322.396176993977;2330.417395651087;2310.06442390832;2310.7573704761094;2373.7982271506944;2374.03851440167;2377.239283429303;7423.62881855905;8411.411201215917;8456.365772567082;8474.533900635462;8499.490030598185;5082.33929589151;5210.374755029383;5221.921671174935;5227.242049902743;5242.004019236333;3310.6854848789326;3486.965130348715;3503.684668379858;3562.287542491486;3578.6421357864006;1181.1908842442867;1194.593838095043;1240.5596013415288;1244.2099266965542;1244.2410129820803;10751.032407083321;10841.83737243942;10892.509837057352;10902.400367979837;10930.945345273301;4250.744955302692;4549.0447006128425;4659.207934651117;4705.106029854317;4747.7626118693925;8694.826103477895;8720;8780.034196238408;8788.60451279694;8825.646974120964;5144.202648589399;5148.897022059537;5161.690298582022;5161.845144645667;5171.922421163686;4638.582527572467;4762.928556071662;4803.519648035169;4811.591014763784;4822.831200907952;3699.3341198583976;3709.221063576625;3722.813859307024;3793.9241215176094;3795.1840354323954;1049.8267785815408;1087.5704096881686;1127.0701671121358;1154.2728081308721;1165.7959857025157;872.2585802068191;897.7351681254046;898.6719847255705;907.1654078248027;913.7395842184945;5458.945410545924;5556.638818476786;5726.226959360516;5745.626534275259;5773.047447171254;952.8856537215579;978.1148061004802;996.4818294486827;1027.4349107990724;1059.6662051453768;3659.2864391443945;3752.099496120911;3801;3809.028697682129;3942.2903877301787;9640.469774162488;9980.301378903552;10007.649732259337;10042.347247428894;10180.745481362877;9807.558659860324;10020.09819116283;10041.447720375449;10048.69853904384;10049.346792458467;6497.675116244169;7788.14330423653;7902.3678105751405;7912.762617121381;7922.76231713038;5417.72683419404;5465.125579907196;5504.284443022381;5637.9718101409235;5658.434156584473;8548.529830859363;8979;9080;9174.174324310845;9255.398399104037;8822.073682263526;9035.90964090377;9317.487538185194;9344.859827102462;9361.157495825408;6008.8798224036145;7196.172440169238;7225.5664660120565;7225.710971561079;7236.457265705199;7739.419543534144;7745.806354841174;7749.3413059890545;7834.451588388758;7863.449558530848;6605.240397354173;7100.218975912542;7352.0442342495135;7442.404607631484;7598.164201937893;7241.275872412716;7294.452916031213;7301.817454563678;7366.4106871449085;7411.888821667571;6403.167588213502;6429.260635027032;6430.64631445275;6471.191101112361;6481.4166724994975;5011.498850114959;5029.949700502948;5031.84904452867;5059.912118894308;5083.18669012971;4943.802247910187;5063.721495317793;5076.847694569169;5088.465711100281;5110.3356563646485 05:01:53 INFO - PROCESS | 3914 | |4;prototype.html;348.83953381444536;356.7752316040894;359.2240759958489;362.9637036296372;364.382371879664;5302.840914772553;5304.522592966632;5401.245364863918;5484.957858006981;5623.887522249558;4617.8152873885;4720.8347707830235;5286.65636733613;5458.754356053977;5470.91793623096;4111.163297324852;4246.554111818261;4290.871273861789;4298.118885628439;4298.3982242486;3485.3552092862774;4128.855490057848;4238.096903621029;4297.677674174433;4334.913301733964;3657.8719744808936;3731.7201209909367;4231.619154276114;4256.893577660552;4261.74429534229;4193.2242535130945;4195.748255104703;4210;4230.038972719109;4239.915201695949;3368.871428071599;3636.4908912752235;3752.8311225994894;3782.602826703184;3807.9619203807883;4125.91748165038;4194.559571245006;4951.8266860659705;5179.585633149339;5327.46725327468;4905.3132561441425;4928.186849169882;4941.678790878617;4944.381952255968;5002.774875130628;5028.421731500851;5743.138529220609;5792.275965504312;5846.912296315559;5847.415258474161;3966.147278335143;4094.754314741125;4124.463819703449;4136.400221967798;4152.408166935609;4583.54164583539;5648.039833228361;6080.695965201722;6092.329843717188;6114.982055921535;3278.8360581970805;3973.4238535412783;4045.4538637284177;4205.179989902001;4210.536840947493;3933.4296527004;4064.1058967027207;4143.585641435832;4233.1956928183545;4244.915101697949;4112.485939257593;4354.804033818486;4444.622207112367;4513.864584062483;4857.635677324215;4955;5702.971485142548;5768.221290125779;5793.36530775378;5911.733971971272;1166.1953252255917;1222.7554489102215;1257.5724253753767;1363.7272545490744;1385.4804448331874;955.8805149356331;967.511406739592;969.9030096990244;976.8534719792088;982.1995074014656;4963.60291176705;5112.948870511322;5145.871353216199;5146.6911985281;5161.948380516222;5177.534021938043;5253.658512196695;5687.744051517691;5760.654360738369;5774.884502310014;4754.619630429557;4785.779626195298;4985.488133239424;5127.6154288428515;5132.230165475134;2747.639918240484;2851.5152424087955;2932.8093673911553;2979.3147576057627;2995.221242476972;5261.447548007481;5301.522862942354;5841.299044114733;5866.853328666817;5939.2575928009;4928.630352723489;5393.83818485446;5552.250446189712;5738.254026976467;5790.507806836382;4791.071321516393;4890.731009794496;5020.949790502122;5504.935459377382;5821.330546987151;4709.835155769531;5081.669691470042;5317.654352467077;5651.124075768263;5651.745671444877;4907.607391408607;4994.475580064186;5276.366835979554;5476.849861529124;5918.816236752753;6215.9432896408625;6218.9427797273665;6243.282022567463;6252.280987686292;6268.928225169725;3568.4468907319406;3683.4843121962413;3843.8270277837005;3879.7866117363815;3971.5631280558537;4864.781084851119;5054.924176137288;5725.427457254241;5846.824595261979;5944.346121926498;4626.791794369329;5335.519803217729;5555.666660000413;5625.5587352482;5687.232223649754;5360.517553420211;5828.5919985602295;5854.736536855767;5862.7654893805475;5942.821715348547;5046;5469.425710300361;5643.26637537134;5723.7424315905055;5763.452472015152;5585.357683866408;5803.82588522345;5807.274090738658;5881;5890.617109888015;4786.074086854762;5697.601167918206;5703.401142879938;5722.370539240764;5764.19301297827 05:01:53 INFO - PROCESS | 3914 | |5;yui.html;675.361783114956;698.4342682427231;770.4760762681375;774.5817258680313;858.0818524179128;13002.414891329889;14917.477888273912;15494.147821869792;15584.454544090959;15655.530334089966;14228.78656820146;14403.63990900228;14409.279536023208;14415.711685766279;15249.856260780458;718.7807718645798;882.4572887674099;885.8272636835819;886.9201771840533;887.2059506741494;866.6143566113083;889.6396959231522;890.9153630405101;891.6344298837478;893.946363218209;912.5665308978248;936.3211671538148;936.6300311377001;937.8405671035906;939.3518472254157;921.1295325917011;925.9629614815399;928.5960607135918;931.2596485793811;933.7945651956559;679.0730652659134;687.295522089857;691.3294104718466;691.7025678958046;694.472201127142;15384.384624615002;15539.611509712235;15556.688866222725;15576;15580.688386232325;12769.616911492578;13165.53920612774;13956.2324072176;14016.649583760385;14233.50182743599;11588.594399195988;11822.763544729058;11853.170278080452;11936;12042.69893252667;3577.83899724513;3628.9818550907075;3644.2347107107275;3678.319510890494;3680.576733675608;61412;96226.51886740592;102925;110558.44720776426;122527;11139.610113645984;11146.331220126818;11244.49399777012;11263.887361126284;11274.267172633752;22010.119595216012;22016.559668806534;22019.22932697348;22122.22572209997;22400.88799555992;7660.655270512841;7867.173946735625;7920.168382319889;8039.437239393186;8047.597620118971;3612.837422316002;4231.365295205682;4301.763403012865;4368.235558777201;4384.4519435070615;3540.592831824322;3672.026912868092;3672.7245456590863;3674.2651469706166;3692.9446058309145;651.2445563146726;653.1867824558456;666.8399584099781;671.2347923367365;676.7665155521337;694.1739330197049;697.1216267502983;724.9090119370314;725.9782206533813;740.4927624577182;9714.514274286257;9727.367721098106;10260.640877569398;10307.433091179908;10337.793244135075;666.9733210671616;691.6576294734139;708.7165133946463;711.3349018667562;736.1607767145458;4336.913261734748;4685.086408150446;4848.369711937426;4917.704937703677;5026.2460630904925;99392.00607993972;104103;104162.95837041685;105616;107179;80518;92779;92802.53598731963;95129.0487095134;96364;49575.256371154464;82197;82939.17060829436;83034.58482707548;83435.16564834396;8733.781655458664;9291.953540232256;9316.95341523288;9768.316217864682;9794.608215671293;39594.60405396025;41667.7916610415;46174.53825461702;47697;48944;61876;62146.37853621406;63400.68299658472;64923.67538162468;65875;10744.30162039465;10759.246852720547;10867.782644347228;10873.891261087289;10989.340639561651;12754.48982040708;12849.743005140032;12934.935325323313;13198.736025279633;13645.727085458433;11664.358460284766;11825.290482571074;12099.939500302442;12111.152219344562;12344.074194435274;12539.811902821282;13192.868071319164;13268.203907765565;13769.449222031408;13865.23741194244;13232.99277348617;13413.408432763987;13549.254790986197;13589.932050339685;14016.229107398784;9682.370645907993;11077.16921230927;11302.943485282522;11607.709807254887;11657.475413606238;9409.964903860433;11461.541538338706;11475;11660.88339116598;11715.886990735866 05:01:53 INFO - PROCESS | 3914 | __end_tp_report 05:01:53 INFO - PROCESS | 3914 | __start_cc_report 05:01:53 INFO - PROCESS | 3914 | _x_x_mozilla_cycle_collect,384 05:01:53 INFO - PROCESS | 3914 | __end_cc_report 05:01:53 INFO - PROCESS | 3914 | __startTimestamp1486126913465__endTimestamp 05:01:53 INFO - PROCESS | 3914 | 05:01:53 INFO - PROCESS | 3914 | ------- Summary: start ------- 05:01:53 INFO - PROCESS | 3914 | Number of tests: 6 05:01:53 INFO - PROCESS | 3914 | 05:01:53 INFO - PROCESS | 3914 | [#0] dojo.html Cycles:165 Average:5683.99 Median:5858.85 stddev:703.44 (12.0%) stddev-sans-first:668.47 05:01:53 INFO - PROCESS | 3914 | Values: 2809.2 2809.5 3015.4 3364.4 3421.6 4464.0 5374.9 5762.9 5807.3 5810.4 4712.7 5747.6 5771.7 5784.1 5799.8 5250.3 5283.8 5314.1 5319.3 5324.5 5278.9 5328.0 5328.8 5330.5 5338.3 4283.5 5147.2 5325.6 5328.0 5361.6 4256.3 5268.1 5269.2 5304.5 5332.8 5210.8 5215.9 5247.8 5253.7 5258.8 5595.8 5742.5 5772.6 5858.2 5858.9 6055.0 6146.8 6152.4 6176.1 6238.3 6288.7 6292.4 6293.2 6319.2 6325.1 5810.2 5816.1 5833.8 5846.2 5857.6 6212.1 6225.7 6230.5 6278.3 6278.5 6127.1 6213.5 6227.2 6227.5 6230.5 6253.6 6307.8 6314.5 6321.6 6322.3 5606.7 6132.5 6174.6 6178.9 6303.1 5451.3 5618.7 5904.3 6011.6 6043.7 4538.7 4907.6 5005.4 5015.3 5033.3 4294.9 4335.4 4391.6 4442.6 4463.3 5556.5 5592.1 5645.0 5645.0 5682.3 5043.4 6070.7 6109.2 6127.4 6144.8 4659.7 4869.8 5658.4 5869.6 5869.7 5506.7 5516.6 5519.4 5523.2 5524.0 6272.5 6296.1 6301.0 6311.7 6351.8 5068.6 6179.0 6211.4 6231.3 6290.4 6238.4 6270.0 6316.1 6317.6 6323.1 5230.8 6176.6 6263.0 6265.2 6267.2 5240.4 5857.0 6207.4 6331.0 6349.5 6129.6 6144.1 6157.3 6176.5 6185.5 6104.8 6176.4 6177.4 6208.6 6223.1 5804.7 5844.6 5994.1 6034.1 6064.7 6029.0 6095.1 6116.4 6141.4 6194.6 5996.4 5997.4 5999.3 6012.1 6030.5 05:01:53 INFO - PROCESS | 3914 | 05:01:53 INFO - PROCESS | 3914 | [#1] ext.html Cycles:180 Average:71019.48 Median:35668.70 stddev:158456.40 (444.2%) stddev-sans-first:158812.32 05:01:53 INFO - PROCESS | 3914 | Values: 449.4 483.6 491.7 508.6 511.1 39129.6 41737.4 41757.6 44131.0 44393.6 43487.0 43496.0 43579.6 43702.8 43795.8 9280.0 9510.4 9514.8 9521.4 11016.4 11026.2 11212.2 11287.9 11302.3 11336.0 11199.7 11268.7 11308.7 11322.8 11333.8 11237.4 11263.5 11290.0 11314.2 11315.7 10995.9 11002.4 11042.1 11055.3 11059.3 36754.0 37084.4 37147.3 37209.8 37239.8 3913.8 3937.4 3970.9 3983.3 4009.5 27694.4 28799.9 28820.1 29541.7 29594.0 3216.7 3242.9 3259.2 3265.1 3329.6 494357.0 494604.0 496513.6 497726.0 499285.0 56991.1 57256.7 57350.7 57387.0 57493.7 59820.1 59897.0 60037.0 60397.0 60492.7 16009.3 16071.4 16210.0 16228.9 16289.9 10965.3 11378.7 11655.7 12484.9 12693.2 14623.4 14643.7 17697.2 17976.4 18066.5 6710.8 7779.6 7938.2 7940.4 7958.2 863.6 882.4 885.7 898.9 918.7 23844.2 26397.3 27665.3 30523.7 30618.0 1069.7 1075.9 1084.8 1086.4 1214.5 13725.4 14213.3 15202.9 15564.5 15588.5 665463.0 667439.0 667481.0 670681.0 673341.0 53160.0 53527.7 53556.7 53720.2 53769.7 1419.4 1429.8 1431.4 1435.1 1453.5 27900.7 28157.0 28985.6 29060.3 29074.9 45255.3 45456.9 45963.9 46010.8 46259.0 592965.0 596598.0 598772.0 600016.0 600815.0 24213.4 25116.0 34989.0 35665.3 37625.8 41252.8 42377.0 42542.6 43509.0 44212.1 35378.3 35763.0 36222.0 36285.6 36360.1 35672.1 35693.0 35874.0 36215.8 36597.0 33892.7 34383.7 34685.0 35022.3 35357.1 29284.9 31250.0 31342.0 31405.0 31480.4 23357.5 23461.4 23792.6 23828.6 23861.0 05:01:53 INFO - PROCESS | 3914 | 05:01:53 INFO - PROCESS | 3914 | [#2] jquery.html Cycles:180 Average:38738.82 Median:25202.25 stddev:118240.51 (469.2%) stddev-sans-first:118537.14 05:01:53 INFO - PROCESS | 3914 | Values: 388.2 391.9 400.9 404.5 412.8 16327.8 19903.1 21205.9 21223.0 21290.3 20866.7 21275.0 21295.7 21369.4 21623.0 5501.9 5906.6 5951.0 6005.1 6041.5 5866.1 5890.6 5966.1 5986.4 6000.9 5657.7 5841.8 5877.4 5882.4 5897.1 5000.9 5624.3 5837.0 5851.6 5866.5 5151.4 5185.2 5189.8 5191.4 5197.4 25175.5 25229.0 25255.1 25392.5 25478.1 3140.3 3154.1 3169.6 3173.6 3188.8 12577.0 15558.5 15596.0 15894.4 16079.4 1810.5 1846.4 1849.4 1852.4 1856.7 96989.0 116373.0 122957.4 124054.0 128041.4 11431.5 11629.7 11710.1 11724.9 11725.8 14527.6 14543.9 14544.7 14547.3 14615.3 8566.8 8697.0 8782.2 8898.6 8920.7 8689.9 8785.4 8788.8 8918.7 8962.5 7095.1 7241.7 7255.2 7275.3 7275.7 1659.9 1673.5 1917.6 1975.0 1978.9 1033.3 1037.9 1044.5 1047.1 1056.5 17055.1 21148.2 21174.4 21461.1 21540.7 959.3 990.1 1019.0 1030.8 1063.8 11146.2 11419.7 11430.9 11439.0 11445.4 652635.0 722575.0 727963.0 731173.0 734657.0 96308.0 117145.0 120256.0 126979.0 127315.4 993.7 1058.5 1097.8 1107.5 1111.5 19364.8 19798.7 20000.5 20040.7 20072.9 61370.0 61819.1 62314.0 62422.1 62941.9 88080.0 89663.1 90791.1 91082.0 91985.5 7883.2 7889.2 7909.4 8101.0 8154.6 11350.4 11741.7 12047.0 12245.5 12831.6 8540.5 8780.5 10071.6 10737.6 11080.4 9339.4 9869.7 10417.8 10741.3 11135.8 10929.8 10950.8 11190.3 11270.0 11309.0 7947.9 8005.8 8114.0 8277.0 8427.7 7966.1 10138.8 10997.8 10998.3 11133.5 05:01:53 INFO - PROCESS | 3914 | 05:01:53 INFO - PROCESS | 3914 | [#3] mootools.html Cycles:180 Average:5416.25 Median:5146.55 stddev:2923.19 (56.8%) stddev-sans-first:2914.64 05:01:53 INFO - PROCESS | 3914 | Values: 1253.2 1428.8 1455.8 1456.4 1476.7 7519.9 7769.3 8100.1 8568.6 8580.0 7990.7 8226.7 8288.5 8386.9 8393.8 2277.8 2317.8 2322.9 2325.5 2334.6 2100.9 2179.1 2314.2 2351.2 2364.4 2254.5 2334.6 2344.2 2346.0 2347.3 2299.0 2302.4 2318.7 2322.4 2330.4 2310.1 2310.8 2373.8 2374.0 2377.2 7423.6 8411.4 8456.4 8474.5 8499.5 5082.3 5210.4 5221.9 5227.2 5242.0 3310.7 3487.0 3503.7 3562.3 3578.6 1181.2 1194.6 1240.6 1244.2 1244.2 10751.0 10841.8 10892.5 10902.4 10930.9 4250.7 4549.0 4659.2 4705.1 4747.8 8694.8 8720.0 8780.0 8788.6 8825.6 5144.2 5148.9 5161.7 5161.8 5171.9 4638.6 4762.9 4803.5 4811.6 4822.8 3699.3 3709.2 3722.8 3793.9 3795.2 1049.8 1087.6 1127.1 1154.3 1165.8 872.3 897.7 898.7 907.2 913.7 5458.9 5556.6 5726.2 5745.6 5773.0 952.9 978.1 996.5 1027.4 1059.7 3659.3 3752.1 3801.0 3809.0 3942.3 9640.5 9980.3 10007.6 10042.3 10180.7 9807.6 10020.1 10041.4 10048.7 10049.3 6497.7 7788.1 7902.4 7912.8 7922.8 5417.7 5465.1 5504.3 5638.0 5658.4 8548.5 8979.0 9080.0 9174.2 9255.4 8822.1 9035.9 9317.5 9344.9 9361.2 6008.9 7196.2 7225.6 7225.7 7236.5 7739.4 7745.8 7749.3 7834.5 7863.4 6605.2 7100.2 7352.0 7442.4 7598.2 7241.3 7294.5 7301.8 7366.4 7411.9 6403.2 6429.3 6430.6 6471.2 6481.4 5011.5 5029.9 5031.8 5059.9 5083.2 4943.8 5063.7 5076.8 5088.5 5110.3 05:01:53 INFO - PROCESS | 3914 | 05:01:53 INFO - PROCESS | 3914 | [#4] prototype.html Cycles:180 Average:4600.88 Median:5024.69 stddev:1384.30 (27.6%) stddev-sans-first:1350.89 05:01:53 INFO - PROCESS | 3914 | Values: 348.8 356.8 359.2 363.0 364.4 5302.8 5304.5 5401.2 5485.0 5623.9 4617.8 4720.8 5286.7 5458.8 5470.9 4111.2 4246.6 4290.9 4298.1 4298.4 3485.4 4128.9 4238.1 4297.7 4334.9 3657.9 3731.7 4231.6 4256.9 4261.7 4193.2 4195.7 4210.0 4230.0 4239.9 3368.9 3636.5 3752.8 3782.6 3808.0 4125.9 4194.6 4951.8 5179.6 5327.5 4905.3 4928.2 4941.7 4944.4 5002.8 5028.4 5743.1 5792.3 5846.9 5847.4 3966.1 4094.8 4124.5 4136.4 4152.4 4583.5 5648.0 6080.7 6092.3 6115.0 3278.8 3973.4 4045.5 4205.2 4210.5 3933.4 4064.1 4143.6 4233.2 4244.9 4112.5 4354.8 4444.6 4513.9 4857.6 4955.0 5703.0 5768.2 5793.4 5911.7 1166.2 1222.8 1257.6 1363.7 1385.5 955.9 967.5 969.9 976.9 982.2 4963.6 5112.9 5145.9 5146.7 5161.9 5177.5 5253.7 5687.7 5760.7 5774.9 4754.6 4785.8 4985.5 5127.6 5132.2 2747.6 2851.5 2932.8 2979.3 2995.2 5261.4 5301.5 5841.3 5866.9 5939.3 4928.6 5393.8 5552.3 5738.3 5790.5 4791.1 4890.7 5020.9 5504.9 5821.3 4709.8 5081.7 5317.7 5651.1 5651.7 4907.6 4994.5 5276.4 5476.8 5918.8 6215.9 6218.9 6243.3 6252.3 6268.9 3568.4 3683.5 3843.8 3879.8 3971.6 4864.8 5054.9 5725.4 5846.8 5944.3 4626.8 5335.5 5555.7 5625.6 5687.2 5360.5 5828.6 5854.7 5862.8 5942.8 5046.0 5469.4 5643.3 5723.7 5763.5 5585.4 5803.8 5807.3 5881.0 5890.6 4786.1 5697.6 5703.4 5722.4 5764.2 05:01:53 INFO - PROCESS | 3914 | 05:01:53 INFO - PROCESS | 3914 | [#5] yui.html Cycles:180 Average:19960.81 Median:22949.58 stddev:29009.49 (126.4%) stddev-sans-first:29054.73 05:01:53 INFO - PROCESS | 3914 | Values: 675.4 698.4 770.5 774.6 858.1 13002.4 14917.5 15494.1 15584.5 15655.5 14228.8 14403.6 14409.3 14415.7 15249.9 718.8 882.5 885.8 886.9 887.2 866.6 889.6 890.9 891.6 893.9 912.6 936.3 936.6 937.8 939.4 921.1 926.0 928.6 931.3 933.8 679.1 687.3 691.3 691.7 694.5 15384.4 15539.6 15556.7 15576.0 15580.7 12769.6 13165.5 13956.2 14016.6 14233.5 11588.6 11822.8 11853.2 11936.0 12042.7 3577.8 3629.0 3644.2 3678.3 3680.6 61412.0 96226.5 102925.0 110558.4 122527.0 11139.6 11146.3 11244.5 11263.9 11274.3 22010.1 22016.6 22019.2 22122.2 22400.9 7660.7 7867.2 7920.2 8039.4 8047.6 3612.8 4231.4 4301.8 4368.2 4384.5 3540.6 3672.0 3672.7 3674.3 3692.9 651.2 653.2 666.8 671.2 676.8 694.2 697.1 724.9 726.0 740.5 9714.5 9727.4 10260.6 10307.4 10337.8 667.0 691.7 708.7 711.3 736.2 4336.9 4685.1 4848.4 4917.7 5026.2 99392.0 104103.0 104163.0 105616.0 107179.0 80518.0 92779.0 92802.5 95129.0 96364.0 49575.3 82197.0 82939.2 83034.6 83435.2 8733.8 9292.0 9317.0 9768.3 9794.6 39594.6 41667.8 46174.5 47697.0 48944.0 61876.0 62146.4 63400.7 64923.7 65875.0 10744.3 10759.2 10867.8 10873.9 10989.3 12754.5 12849.7 12934.9 13198.7 13645.7 11664.4 11825.3 12099.9 12111.2 12344.1 12539.8 13192.9 13268.2 13769.4 13865.2 13233.0 13413.4 13549.3 13589.9 14016.2 9682.4 11077.2 11302.9 11607.7 11657.5 9410.0 11461.5 11475.0 11660.9 11715.9 05:01:53 INFO - PROCESS | 3914 | -------- Summary: end -------- 05:01:53 INFO - PROCESS | 3914 | 05:01:54 INFO - TEST-INFO | 3914: exit 0 05:01:54 INFO - TEST-OK | dromaeo_css | took 1114046ms 05:01:54 INFO - TEST-START | kraken 05:01:54 INFO - operating with platform_type : mac_ 05:01:54 INFO - Initialising browser for kraken test... 05:01:54 INFO - TEST-INFO | started process 3922 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpHgfo2B/profile http://localhost:56782/getInfo.html) 05:01:56 INFO - PROCESS | 3922 | 2017-02-03 05:01:56.751 plugin-container[3923:158246] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 05:01:56 INFO - PROCESS | 3922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:01:56 INFO - PROCESS | 3922 | 2017-02-03 05:01:56.754 plugin-container[3923:158246] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 05:01:56 INFO - PROCESS | 3922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:01:56 INFO - PROCESS | 3922 | 2017-02-03 05:01:56.754 plugin-container[3923:158246] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:01:56 INFO - PROCESS | 3922 | __metrics Screen width/height:1600/1200 05:01:56 INFO - PROCESS | 3922 | colorDepth:24 05:01:56 INFO - PROCESS | 3922 | Browser inner width/height: 1024/689 05:01:56 INFO - PROCESS | 3922 | __metrics 05:01:56 ERROR - PROCESS | 3922 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 05:01:57 INFO - TEST-INFO | 3922: exit 0 05:01:57 INFO - Browser initialized. 05:01:57 INFO - Running cycle 1/1 for kraken test... 05:01:57 INFO - TEST-INFO | started process 3924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpHgfo2B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:00 INFO - PROCESS | 3924 | 2017-02-03 05:02:00.004 plugin-container[3925:158373] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 05:02:00 INFO - PROCESS | 3924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:02:00 INFO - PROCESS | 3924 | 2017-02-03 05:02:00.005 plugin-container[3925:158373] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 05:02:00 INFO - PROCESS | 3924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:02:00 INFO - PROCESS | 3924 | 2017-02-03 05:02:00.005 plugin-container[3925:158373] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:02:09 INFO - PROCESS | 3924 | RSS: Main: 218710016 05:02:09 INFO - PROCESS | 3924 | 05:02:12 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56782/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:13 INFO - PROCESS | 3924 | RSS: Main: 233295872 05:02:13 INFO - PROCESS | 3924 | 05:02:16 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56782/tests/kraken/driver.html?testName=audio-dft) 05:02:17 INFO - PROCESS | 3924 | RSS: Main: 241016832 05:02:17 INFO - PROCESS | 3924 | 05:02:20 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56782/tests/kraken/driver.html?testName=audio-fft) 05:02:21 INFO - PROCESS | 3924 | RSS: Main: 242688000 05:02:21 INFO - PROCESS | 3924 | 05:02:23 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56782/tests/kraken/driver.html?testName=audio-oscillator) 05:02:23 INFO - PROCESS | 3924 | RSS: Main: 245407744 05:02:23 INFO - PROCESS | 3924 | 05:02:25 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56782/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:26 INFO - PROCESS | 3924 | RSS: Main: 246075392 05:02:26 INFO - PROCESS | 3924 | 05:02:29 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56782/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:30 INFO - PROCESS | 3924 | RSS: Main: 249868288 05:02:30 INFO - PROCESS | 3924 | 05:02:33 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56782/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:33 INFO - PROCESS | 3924 | RSS: Main: 248979456 05:02:33 INFO - PROCESS | 3924 | 05:02:36 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56782/tests/kraken/driver.html?testName=json-parse-financial) 05:02:37 INFO - PROCESS | 3924 | RSS: Main: 249073664 05:02:37 INFO - PROCESS | 3924 | 05:02:38 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56782/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:39 INFO - PROCESS | 3924 | RSS: Main: 248573952 05:02:39 INFO - PROCESS | 3924 | 05:02:41 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56782/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:42 INFO - PROCESS | 3924 | RSS: Main: 248553472 05:02:42 INFO - PROCESS | 3924 | 05:02:44 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56782/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:02:45 INFO - PROCESS | 3924 | RSS: Main: 248676352 05:02:45 INFO - PROCESS | 3924 | 05:02:48 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:02:48 INFO - PROCESS | 3924 | RSS: Main: 248983552 05:02:48 INFO - PROCESS | 3924 | 05:02:52 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:02:52 INFO - PROCESS | 3924 | RSS: Main: 248811520 05:02:52 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:56782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56782/tests/kraken/driver.html?testName=ai-astar) 05:02:54 INFO - PROCESS | 3924 | RSS: Main: 250720256 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | __start_tp_report 05:02:54 INFO - PROCESS | 3924 | _x_x_mozilla_page_load 05:02:54 INFO - PROCESS | 3924 | _x_x_mozilla_page_load_details 05:02:54 INFO - PROCESS | 3924 | |i|pagename|runs| 05:02:54 INFO - PROCESS | 3924 | |0;ai-astar;107;120;119;133;108;116;125;167;104;161 05:02:54 INFO - PROCESS | 3924 | |1;audio-beat-detection;155;106;117;157;130;140;142;114;157;143 05:02:54 INFO - PROCESS | 3924 | |2;audio-dft;196;211;215;172;214;247;272;256;198;196 05:02:54 INFO - PROCESS | 3924 | |3;audio-fft;83;73;56;84;76;49;50;63;95;83 05:02:54 INFO - PROCESS | 3924 | |4;audio-oscillator;89;59;86;98;98;60;97;88;100;111 05:02:54 INFO - PROCESS | 3924 | |5;imaging-gaussian-blur;89;90;90;103;89;85;92;86;83;130 05:02:54 INFO - PROCESS | 3924 | |6;imaging-darkroom;94;95;102;94;96;95;146;102;97;147 05:02:54 INFO - PROCESS | 3924 | |7;imaging-desaturate;91;95;108;92;93;94;93;97;93;91 05:02:54 INFO - PROCESS | 3924 | |8;json-parse-financial;60;63;61;94;88;63;63;63;63;64 05:02:54 INFO - PROCESS | 3924 | |9;json-stringify-tinderbox;69;78;93;70;87;111;105;105;103;74 05:02:54 INFO - PROCESS | 3924 | |10;stanford-crypto-aes;93;74;98;104;106;85;88;94;82;78 05:02:54 INFO - PROCESS | 3924 | |11;stanford-crypto-ccm;176;153;140;149;158;154;153;162;201;181 05:02:54 INFO - PROCESS | 3924 | |12;stanford-crypto-pbkdf2;170;229;228;219;168;174;230;219;175;166 05:02:54 INFO - PROCESS | 3924 | |13;stanford-crypto-sha256-iterative;69;91;79;77;73;58;84;84;86;66 05:02:54 INFO - PROCESS | 3924 | __end_tp_report 05:02:54 INFO - PROCESS | 3924 | __start_cc_report 05:02:54 INFO - PROCESS | 3924 | _x_x_mozilla_cycle_collect,933 05:02:54 INFO - PROCESS | 3924 | __end_cc_report 05:02:54 INFO - PROCESS | 3924 | __startTimestamp1486126974855__endTimestamp 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | ------- Summary: start ------- 05:02:54 INFO - PROCESS | 3924 | Number of tests: 14 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#0] ai-astar Cycles:10 Average:126.00 Median:122.50 stddev:21.88 (17.9%) stddev-sans-first:22.10 05:02:54 INFO - PROCESS | 3924 | Values: 107.0 120.0 119.0 133.0 108.0 116.0 125.0 167.0 104.0 161.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:142.50 stddev:18.63 (13.1%) stddev-sans-first:18.47 05:02:54 INFO - PROCESS | 3924 | Values: 155.0 106.0 117.0 157.0 130.0 140.0 142.0 114.0 157.0 143.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#2] audio-dft Cycles:10 Average:217.70 Median:214.50 stddev:31.19 (14.5%) stddev-sans-first:32.08 05:02:54 INFO - PROCESS | 3924 | Values: 196.0 211.0 215.0 172.0 214.0 247.0 272.0 256.0 198.0 196.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#3] audio-fft Cycles:10 Average:71.20 Median:79.50 stddev:15.90 (20.0%) stddev-sans-first:16.28 05:02:54 INFO - PROCESS | 3924 | Values: 83.0 73.0 56.0 84.0 76.0 49.0 50.0 63.0 95.0 83.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:88.50 stddev:16.93 (19.1%) stddev-sans-first:17.96 05:02:54 INFO - PROCESS | 3924 | Values: 89.0 59.0 86.0 98.0 98.0 60.0 97.0 88.0 100.0 111.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:89.00 stddev:13.86 (15.6%) stddev-sans-first:14.59 05:02:54 INFO - PROCESS | 3924 | Values: 89.0 90.0 90.0 103.0 89.0 85.0 92.0 86.0 83.0 130.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#6] imaging-darkroom Cycles:10 Average:106.80 Median:94.50 stddev:21.13 (22.4%) stddev-sans-first:21.90 05:02:54 INFO - PROCESS | 3924 | Values: 94.0 95.0 102.0 94.0 96.0 95.0 146.0 102.0 97.0 147.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:93.00 stddev:5.01 (5.4%) stddev-sans-first:5.13 05:02:54 INFO - PROCESS | 3924 | Values: 91.0 95.0 108.0 92.0 93.0 94.0 93.0 97.0 93.0 91.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:63.00 stddev:12.15 (19.3%) stddev-sans-first:12.52 05:02:54 INFO - PROCESS | 3924 | Values: 60.0 63.0 61.0 94.0 88.0 63.0 63.0 63.0 63.0 64.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#9] json-stringify-tinderbox Cycles:10 Average:89.50 Median:72.00 stddev:16.04 (22.3%) stddev-sans-first:15.21 05:02:54 INFO - PROCESS | 3924 | Values: 69.0 78.0 93.0 70.0 87.0 111.0 105.0 105.0 103.0 74.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:86.50 stddev:10.72 (12.4%) stddev-sans-first:11.32 05:02:54 INFO - PROCESS | 3924 | Values: 93.0 74.0 98.0 104.0 106.0 85.0 88.0 94.0 82.0 78.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#11] stanford-crypto-ccm Cycles:10 Average:162.70 Median:160.00 stddev:18.16 (11.4%) stddev-sans-first:18.61 05:02:54 INFO - PROCESS | 3924 | Values: 176.0 153.0 140.0 149.0 158.0 154.0 153.0 162.0 201.0 181.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.80 Median:219.00 stddev:29.02 (13.3%) stddev-sans-first:28.98 05:02:54 INFO - PROCESS | 3924 | Values: 170.0 229.0 228.0 219.0 168.0 174.0 230.0 219.0 175.0 166.0 05:02:54 INFO - PROCESS | 3924 | 05:02:54 INFO - PROCESS | 3924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:81.50 stddev:10.22 (12.5%) stddev-sans-first:10.45 05:02:54 INFO - PROCESS | 3924 | Values: 69.0 91.0 79.0 77.0 73.0 58.0 84.0 84.0 86.0 66.0 05:02:54 INFO - PROCESS | 3924 | -------- Summary: end -------- 05:02:54 INFO - PROCESS | 3924 | 05:02:55 INFO - TEST-INFO | 3924: exit 0 05:02:55 INFO - TEST-OK | kraken | took 61620ms 05:02:55 INFO - SUITE-END | took 1175s 05:02:56 INFO - Completed test suite (00:19:35) 05:02:56 INFO - javascript benchmark 05:02:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7322.203273496112, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2809.19937817722, 2809.5083360411923, 3015.381846721422, 3364.44486659701, 3421.5723034620673, 4464.017916058466, 5374.89250214996, 5762.913556296654, 5807.274090738658, 5810.3899090595405, 4712.670113092085, 5747.59766816323, 5771.653700777956, 5784.074548072309, 5799.797007104752, 5250.343707036621, 5283.8150664726745, 5314.096603577401, 5319.308489896308, 5324.520793128618, 5278.9208161877605, 5328.014317351302, 5328.8401347959625, 5330.493603107699, 5338.332708411449, 4283.464566929134, 5147.202183661539, 5325.627206095575, 5328.0, 5361.571074314045, 4256.340267258564, 5268.104422248189, 5269.235960785664, 5304.469553044703, 5332.76002579881, 5210.817621383233, 5215.895682086375, 5247.816326428557, 5253.684778913277, 5258.789648414059, 5595.776168953237, 5742.483176514092, 5772.624779389326, 5858.179854820329, 5858.853528661817, 6054.96972515139, 6146.815595532141, 6152.3540028297275, 6176.135341052256, 6238.251409830804, 6288.748450061992, 6292.370762923671, 6293.244810622708, 6319.24169099711, 6325.05124231369, 5810.1865738796605, 5816.12758086282, 5833.766649334021, 5846.210761547137, 5857.648541087506, 6212.1303017577575, 6225.688715564203, 6230.470410015108, 6278.340774218641, 6278.46633036197, 6127.111568822495, 6213.5339849511465, 6227.159333489921, 6227.470664993436, 6230.501559875199, 6253.624782513064, 6307.842303942346, 6314.526410519229, 6321.620702757849, 6322.272938612026, 5606.719664016783, 6132.50939924805, 6174.598651087665, 6178.907316390258, 6303.117563541108, 5451.291332126798, 5618.735784448467, 5904.321003084614, 6011.609245399122, 6043.700604370081, 4538.72767633943, 4907.631927605373, 5005.374328208974, 5015.322931404214, 5033.345665063592, 4294.892627684333, 4335.414719012893, 4391.5827996340295, 4442.644588432918, 4463.308187230984, 5556.472135147154, 5592.133219351007, 5644.955683198621, 5645.012122878562, 5682.289713785777, 5043.394792624908, 6070.666113363807, 6109.175261339751, 6127.417895299939, 6144.846378840475, 4659.743714095689, 4869.780859861315, 5658.405867383865, 5869.589128760946, 5869.735861886225, 5506.697131657797, 5516.558675305966, 5519.448055194448, 5523.199136125239, 5524.0, 6272.498200143978, 6296.087067375205, 6300.9684951574945, 6311.747530098928, 6351.777687780906, 5068.6451948363265, 6178.969105154445, 6211.378862113933, 6231.2522497300615, 6290.370962903673, 6238.376162383907, 6270.0, 6316.11574379578, 6317.557770955989, 6323.114763933145, 5230.8169214077325, 6176.60286842226, 6262.966610509215, 6265.154204182377, 6267.2165979252595, 5240.371155461369, 5857.0043092673495, 6207.441330280297, 6330.968345158245, 6349.49204063683, 6129.601575897553, 6144.064619644798, 6157.32269450369, 6176.505879529716, 6185.474234689922, 6104.816855494342, 6176.413240742122, 6177.444030037318, 6208.565400421927, 6223.097650840693, 5804.709764511842, 5844.620099693507, 5994.10088486713, 6034.125051867542, 6064.7175900754855, 6028.969855150696, 6095.146679464967, 6116.418940200674, 6141.36327073057, 6194.628322300677, 5996.400359963969, 5997.370276121119, 5999.3100793407575, 6012.128241405059, 6030.4572588467245], "value": 5637.232389686944, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.4067830463789, 483.57928602116164, 491.7295487481884, 508.6236185222936, 511.11832089645367, 39129.608703912985, 41737.3739393909, 41757.58242417575, 44131.0, 44393.55606443935, 43487.0, 43496.0, 43579.56420435795, 43702.7814860926, 43795.78102109493, 9279.999999999984, 9510.38182518134, 9514.80970380592, 9521.381110227847, 11016.449177541132, 11026.228164028522, 11212.159088068387, 11287.943560282187, 11302.265352752085, 11336.036436902874, 11199.720006999809, 11268.718282042973, 11308.660740177807, 11322.773544529146, 11333.829992550118, 11237.438128093603, 11263.493142808593, 11290.040346570551, 11314.208005439581, 11315.717107072307, 10995.945020274927, 11002.394868282241, 11042.116630669527, 11055.336679799157, 11059.336439813636, 36754.0, 37084.44373334402, 37147.257054858754, 37209.813950930344, 37239.813800930824, 3913.7847418391975, 3937.3700207966876, 3970.9007274818073, 3983.2630963271886, 4009.518857737061, 27694.44611107787, 28799.856000720072, 28820.135395938156, 29541.70458295411, 29594.0, 3216.662250463691, 3242.8702851885896, 3259.2014956335847, 3265.0694552052787, 3329.6170940341926, 494357.0, 494604.0, 496513.55229671585, 497726.0, 499285.0, 56991.14513282304, 57256.71371643115, 57350.7132464335, 57387.0, 57493.71253143708, 59820.10269845956, 59897.0, 60037.0, 60397.0, 60492.69753651204, 16009.27958241882, 16071.35714571404, 16210.027398356136, 16228.918855405884, 16289.918550407408, 10965.287256328313, 11378.715532111597, 11655.650330490098, 12484.875151248552, 12693.238405695687, 14623.415063397344, 14643.707125857423, 17697.203625836868, 17976.370827021252, 18066.458006259832, 6710.798676039629, 7779.57212353326, 7938.166492518202, 7940.3548923879025, 7958.164392738795, 863.6156910175038, 882.4220135811054, 885.7298523950257, 898.9325800564984, 918.7151982885327, 23844.16545420902, 26397.340066498105, 27665.308367290978, 30523.69476305253, 30618.0, 1069.7165251208437, 1075.9246852720391, 1084.7613525024483, 1086.4296244471557, 1214.489914236023, 13725.382357793924, 14213.289335533182, 15202.9357944945, 15564.533064008097, 15588.454404095803, 665463.0, 667439.0, 667481.0, 670681.0, 673341.0, 53160.0, 53527.73236133794, 53556.73221633867, 53720.194197087076, 53769.73115134478, 1419.425132821209, 1429.7855321701827, 1431.3701971132668, 1435.0743770268118, 1453.5130731204954, 27900.720992790626, 28157.0, 28985.56521652219, 29060.27349316284, 29074.854625726737, 45255.32117018313, 45456.863578410805, 45963.850903727674, 46010.76994615005, 46259.0, 592965.0, 596598.0, 598772.0, 600016.0, 600815.0, 24213.394665133514, 25116.0, 34989.0, 35665.28669426649, 37625.81187094047, 41252.793736031126, 42377.0, 42542.5745742551, 43509.0, 44212.11575768531, 35378.29243415066, 35763.0, 36222.0, 36285.63714362823, 36360.09099772421, 35672.108197295274, 35693.0, 35874.0, 36215.81892090523, 36597.0, 33892.661073389936, 34383.656163439045, 34684.959451216506, 35022.29955400827, 35357.116072098404, 29284.853575731984, 31250.0, 31342.0, 31405.0, 31480.37039259248, 23357.532849343257, 23461.41346466352, 23792.643110353012, 23828.642570361804, 23861.0], "value": 19910.582085899543, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.22161566060043, 391.92553414851193, 400.85769551809096, 404.48832227232555, 412.8049297284362, 16327.755083673725, 19903.1043603038, 21205.939703014865, 21223.0, 21290.254841080565, 20866.68699969498, 21275.0, 21295.68056479154, 21369.358919232447, 21623.0, 5501.9174712379245, 5906.586538942276, 5950.97024514879, 6005.12925625784, 6041.546883983697, 5866.149408335788, 5890.587658863881, 5966.075258334943, 5986.371430999748, 6000.879982400371, 5657.66054036757, 5841.824745257649, 5877.441643043904, 5882.3529411764675, 5897.056470964647, 5000.924986125211, 5624.325080990287, 5837.0, 5851.590388672795, 5866.530677545786, 5151.4333423323405, 5185.248139019821, 5189.818356357547, 5191.351081114861, 5197.350331208599, 25175.49649007028, 25229.0, 25255.116070937613, 25392.49215015708, 25478.10826621078, 3140.3248301615035, 3154.148379937427, 3169.635491918436, 3173.5715678383353, 3188.8246146461934, 12577.0, 15558.533244002698, 15595.986260893005, 15894.364225430969, 16079.437219697254, 1810.520212143783, 1846.4276074416973, 1849.3712137873054, 1852.3516769130697, 1856.712209607513, 96989.0, 116373.0, 122957.38521307426, 124054.0, 128041.35979320137, 11431.485583148778, 11629.651110466699, 11710.063194944383, 11724.88275117238, 11725.765484690259, 14527.636809079857, 14543.92728036353, 14544.709105818036, 14547.27263636814, 14615.26923653813, 8566.78583035429, 8696.956515217384, 8782.165694259164, 8898.55507224649, 8920.73237802867, 8689.913100869036, 8785.385023048326, 8788.824223515621, 8918.687845925362, 8962.507062111516, 7095.077639906779, 7241.674124664298, 7255.23819998903, 7275.345218930322, 7275.67259473325, 1659.8838081334432, 1673.5314112048645, 1917.6260629177455, 1974.960500789976, 1978.920843166286, 1033.338663255517, 1037.8910214427376, 1044.498640652491, 1047.068109382635, 1056.4559251985233, 17055.147242638068, 21148.15407383718, 21174.364769056952, 21461.141554337963, 21540.676889846665, 959.29971121082, 990.1286867556504, 1018.9592416303414, 1030.8041472120274, 1063.7925604507047, 11146.219764616399, 11419.657410277705, 11430.885691142983, 11438.9704926557, 11445.370504622326, 652635.0, 722575.0, 727963.0, 731173.0, 734657.0, 96307.9552097847, 117145.0, 120256.0, 126979.0, 127315.36342318414, 993.6621548673486, 1058.5183741397645, 1097.7694684116266, 1107.4628805029554, 1111.5331560744507, 19364.806351936862, 19798.703019455006, 20000.49998750043, 20040.69938950946, 20072.899635502312, 61370.0, 61819.07271390843, 62314.0, 62422.063669044095, 62941.933681258626, 88080.0, 89663.10336896547, 90791.09208907826, 91082.0, 91985.5400722992, 7883.172266912121, 7889.171636978264, 7909.367250620052, 8101.0, 8154.633041513028, 11350.432478375884, 11741.706457338634, 12046.9760070395, 12245.510179593073, 12831.615051548468, 8540.487570745776, 8780.517071561126, 10071.647492337734, 10737.624183153552, 11080.445977701243, 9339.439633621732, 9869.654562090293, 10417.84373234387, 10741.281394977079, 11135.832962505407, 10929.836052459379, 10950.835737463785, 11190.272632278877, 11269.985701286923, 11309.038731707897, 7947.8807817881625, 8005.759827205193, 8114.026316842017, 8276.958615206886, 8427.705030323908, 7966.083900351534, 10138.797224055625, 10997.835032474359, 10998.34009959405, 11133.498992545194], "value": 10013.617105167012, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.2417887178258, 1428.7785393264048, 1455.803466532018, 1456.410153887676, 1476.7194233095715, 7519.924800751991, 7769.261920117579, 8100.108988011321, 8568.614412351444, 8579.957100214506, 7990.720324788634, 8226.712065077723, 8288.502689838613, 8386.91613083869, 8393.83212335753, 2277.817774578034, 2317.7798109179685, 2322.8722420266877, 2325.534893021394, 2334.579775640384, 2100.9369718908456, 2179.095675294751, 2314.201600447843, 2351.235848349285, 2364.3970787449175, 2254.4701995031155, 2334.6381310896836, 2344.2146880794953, 2345.976540234593, 2347.295811256625, 2299.034405549665, 2302.3783578433895, 2318.7333456652364, 2322.396176993977, 2330.417395651087, 2310.06442390832, 2310.7573704761094, 2373.7982271506944, 2374.03851440167, 2377.239283429303, 7423.62881855905, 8411.411201215917, 8456.365772567082, 8474.533900635462, 8499.490030598185, 5082.33929589151, 5210.374755029383, 5221.921671174935, 5227.242049902743, 5242.004019236333, 3310.6854848789326, 3486.965130348715, 3503.684668379858, 3562.287542491486, 3578.6421357864006, 1181.1908842442867, 1194.593838095043, 1240.5596013415288, 1244.2099266965542, 1244.2410129820803, 10751.032407083321, 10841.83737243942, 10892.509837057352, 10902.400367979837, 10930.945345273301, 4250.744955302692, 4549.0447006128425, 4659.207934651117, 4705.106029854317, 4747.7626118693925, 8694.826103477895, 8720.0, 8780.034196238408, 8788.60451279694, 8825.646974120964, 5144.202648589399, 5148.897022059537, 5161.690298582022, 5161.845144645667, 5171.922421163686, 4638.582527572467, 4762.928556071662, 4803.519648035169, 4811.591014763784, 4822.831200907952, 3699.3341198583976, 3709.221063576625, 3722.813859307024, 3793.9241215176094, 3795.1840354323954, 1049.8267785815408, 1087.5704096881686, 1127.0701671121358, 1154.2728081308721, 1165.7959857025157, 872.2585802068191, 897.7351681254046, 898.6719847255705, 907.1654078248027, 913.7395842184945, 5458.945410545924, 5556.638818476786, 5726.226959360516, 5745.626534275259, 5773.047447171254, 952.8856537215579, 978.1148061004802, 996.4818294486827, 1027.4349107990724, 1059.6662051453768, 3659.2864391443945, 3752.099496120911, 3801.0, 3809.028697682129, 3942.2903877301787, 9640.469774162488, 9980.301378903552, 10007.649732259337, 10042.347247428894, 10180.745481362877, 9807.558659860324, 10020.09819116283, 10041.447720375449, 10048.69853904384, 10049.346792458467, 6497.675116244169, 7788.14330423653, 7902.3678105751405, 7912.762617121381, 7922.76231713038, 5417.72683419404, 5465.125579907196, 5504.284443022381, 5637.9718101409235, 5658.434156584473, 8548.529830859363, 8979.0, 9080.0, 9174.174324310845, 9255.398399104037, 8822.073682263526, 9035.90964090377, 9317.487538185194, 9344.859827102462, 9361.157495825408, 6008.8798224036145, 7196.172440169238, 7225.5664660120565, 7225.710971561079, 7236.457265705199, 7739.419543534144, 7745.806354841174, 7749.3413059890545, 7834.451588388758, 7863.449558530848, 6605.240397354173, 7100.218975912542, 7352.0442342495135, 7442.404607631484, 7598.164201937893, 7241.275872412716, 7294.452916031213, 7301.817454563678, 7366.4106871449085, 7411.888821667571, 6403.167588213502, 6429.260635027032, 6430.64631445275, 6471.191101112361, 6481.4166724994975, 5011.498850114959, 5029.949700502948, 5031.84904452867, 5059.912118894308, 5083.18669012971, 4943.802247910187, 5063.721495317793, 5076.847694569169, 5088.465711100281, 5110.3356563646485], "value": 4413.348416439904, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.83953381444536, 356.7752316040894, 359.2240759958489, 362.9637036296372, 364.382371879664, 5302.840914772553, 5304.522592966632, 5401.245364863918, 5484.957858006981, 5623.887522249558, 4617.8152873885, 4720.8347707830235, 5286.65636733613, 5458.754356053977, 5470.91793623096, 4111.163297324852, 4246.554111818261, 4290.871273861789, 4298.118885628439, 4298.3982242486, 3485.3552092862774, 4128.855490057848, 4238.096903621029, 4297.677674174433, 4334.913301733964, 3657.8719744808936, 3731.7201209909367, 4231.619154276114, 4256.893577660552, 4261.74429534229, 4193.2242535130945, 4195.748255104703, 4210.0, 4230.038972719109, 4239.915201695949, 3368.871428071599, 3636.4908912752235, 3752.8311225994894, 3782.602826703184, 3807.9619203807883, 4125.91748165038, 4194.559571245006, 4951.8266860659705, 5179.585633149339, 5327.46725327468, 4905.3132561441425, 4928.186849169882, 4941.678790878617, 4944.381952255968, 5002.774875130628, 5028.421731500851, 5743.138529220609, 5792.275965504312, 5846.912296315559, 5847.415258474161, 3966.147278335143, 4094.754314741125, 4124.463819703449, 4136.400221967798, 4152.408166935609, 4583.54164583539, 5648.039833228361, 6080.695965201722, 6092.329843717188, 6114.982055921535, 3278.8360581970805, 3973.4238535412783, 4045.4538637284177, 4205.179989902001, 4210.536840947493, 3933.4296527004, 4064.1058967027207, 4143.585641435832, 4233.1956928183545, 4244.915101697949, 4112.485939257593, 4354.804033818486, 4444.622207112367, 4513.864584062483, 4857.635677324215, 4955.0, 5702.971485142548, 5768.221290125779, 5793.36530775378, 5911.733971971272, 1166.1953252255917, 1222.7554489102215, 1257.5724253753767, 1363.7272545490744, 1385.4804448331874, 955.8805149356331, 967.511406739592, 969.9030096990244, 976.8534719792088, 982.1995074014656, 4963.60291176705, 5112.948870511322, 5145.871353216199, 5146.6911985281, 5161.948380516222, 5177.534021938043, 5253.658512196695, 5687.744051517691, 5760.654360738369, 5774.884502310014, 4754.619630429557, 4785.779626195298, 4985.488133239424, 5127.6154288428515, 5132.230165475134, 2747.639918240484, 2851.5152424087955, 2932.8093673911553, 2979.3147576057627, 2995.221242476972, 5261.447548007481, 5301.522862942354, 5841.299044114733, 5866.853328666817, 5939.2575928009, 4928.630352723489, 5393.83818485446, 5552.250446189712, 5738.254026976467, 5790.507806836382, 4791.071321516393, 4890.731009794496, 5020.949790502122, 5504.935459377382, 5821.330546987151, 4709.835155769531, 5081.669691470042, 5317.654352467077, 5651.124075768263, 5651.745671444877, 4907.607391408607, 4994.475580064186, 5276.366835979554, 5476.849861529124, 5918.816236752753, 6215.9432896408625, 6218.9427797273665, 6243.282022567463, 6252.280987686292, 6268.928225169725, 3568.4468907319406, 3683.4843121962413, 3843.8270277837005, 3879.7866117363815, 3971.5631280558537, 4864.781084851119, 5054.924176137288, 5725.427457254241, 5846.824595261979, 5944.346121926498, 4626.791794369329, 5335.519803217729, 5555.666660000413, 5625.5587352482, 5687.232223649754, 5360.517553420211, 5828.5919985602295, 5854.736536855767, 5862.7654893805475, 5942.821715348547, 5046.0, 5469.425710300361, 5643.26637537134, 5723.7424315905055, 5763.452472015152, 5585.357683866408, 5803.82588522345, 5807.274090738658, 5881.0, 5890.617109888015, 4786.074086854762, 5697.601167918206, 5703.401142879938, 5722.370539240764, 5764.19301297827], "value": 4175.6824988159515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.361783114956, 698.4342682427231, 770.4760762681375, 774.5817258680313, 858.0818524179128, 13002.414891329889, 14917.477888273912, 15494.147821869792, 15584.454544090959, 15655.530334089966, 14228.78656820146, 14403.63990900228, 14409.279536023208, 14415.711685766279, 15249.856260780458, 718.7807718645798, 882.4572887674099, 885.8272636835819, 886.9201771840533, 887.2059506741494, 866.6143566113083, 889.6396959231522, 890.9153630405101, 891.6344298837478, 893.946363218209, 912.5665308978248, 936.3211671538148, 936.6300311377001, 937.8405671035906, 939.3518472254157, 921.1295325917011, 925.9629614815399, 928.5960607135918, 931.2596485793811, 933.7945651956559, 679.0730652659134, 687.295522089857, 691.3294104718466, 691.7025678958046, 694.472201127142, 15384.384624615002, 15539.611509712235, 15556.688866222725, 15576.0, 15580.688386232325, 12769.616911492578, 13165.53920612774, 13956.2324072176, 14016.649583760385, 14233.50182743599, 11588.594399195988, 11822.763544729058, 11853.170278080452, 11936.0, 12042.69893252667, 3577.83899724513, 3628.9818550907075, 3644.2347107107275, 3678.319510890494, 3680.576733675608, 61412.0, 96226.51886740592, 102925.0, 110558.44720776426, 122527.0, 11139.610113645984, 11146.331220126818, 11244.49399777012, 11263.887361126284, 11274.267172633752, 22010.119595216012, 22016.559668806534, 22019.22932697348, 22122.22572209997, 22400.88799555992, 7660.655270512841, 7867.173946735625, 7920.168382319889, 8039.437239393186, 8047.597620118971, 3612.837422316002, 4231.365295205682, 4301.763403012865, 4368.235558777201, 4384.4519435070615, 3540.592831824322, 3672.026912868092, 3672.7245456590863, 3674.2651469706166, 3692.9446058309145, 651.2445563146726, 653.1867824558456, 666.8399584099781, 671.2347923367365, 676.7665155521337, 694.1739330197049, 697.1216267502983, 724.9090119370314, 725.9782206533813, 740.4927624577182, 9714.514274286257, 9727.367721098106, 10260.640877569398, 10307.433091179908, 10337.793244135075, 666.9733210671616, 691.6576294734139, 708.7165133946463, 711.3349018667562, 736.1607767145458, 4336.913261734748, 4685.086408150446, 4848.369711937426, 4917.704937703677, 5026.2460630904925, 99392.00607993972, 104103.0, 104162.95837041685, 105616.0, 107179.0, 80518.0, 92779.0, 92802.53598731963, 95129.0487095134, 96364.0, 49575.256371154464, 82197.0, 82939.17060829436, 83034.58482707548, 83435.16564834396, 8733.781655458664, 9291.953540232256, 9316.95341523288, 9768.316217864682, 9794.608215671293, 39594.60405396025, 41667.7916610415, 46174.53825461702, 47697.0, 48944.0, 61876.0, 62146.37853621406, 63400.68299658472, 64923.67538162468, 65875.0, 10744.30162039465, 10759.246852720547, 10867.782644347228, 10873.891261087289, 10989.340639561651, 12754.48982040708, 12849.743005140032, 12934.935325323313, 13198.736025279633, 13645.727085458433, 11664.358460284766, 11825.290482571074, 12099.939500302442, 12111.152219344562, 12344.074194435274, 12539.811902821282, 13192.868071319164, 13268.203907765565, 13769.449222031408, 13865.23741194244, 13232.99277348617, 13413.408432763987, 13549.254790986197, 13589.932050339685, 14016.229107398784, 9682.370645907993, 11077.16921230927, 11302.943485282522, 11607.709807254887, 11657.475413606238, 9409.964903860433, 11461.541538338706, 11475.0, 11660.88339116598, 11715.886990735866], "value": 7439.898399718528, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1619.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 119.0, 133.0, 108.0, 116.0, 125.0, 167.0, 104.0, 161.0], "value": 126.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 106.0, 117.0, 157.0, 130.0, 140.0, 142.0, 114.0, 157.0, 143.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 211.0, 215.0, 172.0, 214.0, 247.0, 272.0, 256.0, 198.0, 196.0], "value": 217.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 73.0, 56.0, 84.0, 76.0, 49.0, 50.0, 63.0, 95.0, 83.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 59.0, 86.0, 98.0, 98.0, 60.0, 97.0, 88.0, 100.0, 111.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 90.0, 103.0, 89.0, 85.0, 92.0, 86.0, 83.0, 130.0], "value": 93.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 102.0, 94.0, 96.0, 95.0, 146.0, 102.0, 97.0, 147.0], "value": 106.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 108.0, 92.0, 93.0, 94.0, 93.0, 97.0, 93.0, 91.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 61.0, 94.0, 88.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 93.0, 70.0, 87.0, 111.0, 105.0, 105.0, 103.0, 74.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 74.0, 98.0, 104.0, 106.0, 85.0, 88.0, 94.0, 82.0, 78.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 153.0, 140.0, 149.0, 158.0, 154.0, 153.0, 162.0, 201.0, 181.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 229.0, 228.0, 219.0, 168.0, 174.0, 230.0, 219.0, 175.0, 166.0], "value": 197.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 91.0, 79.0, 77.0, 73.0, 58.0, 84.0, 84.0, 86.0, 66.0], "value": 76.7, "unit": "score"}]}]} 05:02:56 INFO - Return code: 0 05:02:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:02:56 ERROR - # TBPL SUCCESS # 05:02:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:02:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:02:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:02:56 INFO - 2017-02-03 05:02:56.168 screenresolution[3929:158756] starting screenresolution argv=screenresolution get 05:02:56 INFO - 2017-02-03 05:02:56.171 screenresolution[3929:158756] Display 0: 1600x1200x32@60 05:02:56 INFO - 2017-02-03 05:02:56.176 screenresolution[3930:158759] starting screenresolution argv=screenresolution list 05:02:56 INFO - Available Modes on Display 0 05:02:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:02:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:02:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:02:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:02:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:02:56 INFO - Intel Iris: 05:02:56 INFO - Chipset Model: Intel Iris 05:02:56 INFO - Type: GPU 05:02:56 INFO - Bus: Built-In 05:02:56 INFO - VRAM (Dynamic, Max): 1536 MB 05:02:56 INFO - Vendor: Intel (0x8086) 05:02:56 INFO - Device ID: 0x0a2e 05:02:56 INFO - Revision ID: 0x0009 05:02:56 INFO - Displays: 05:02:56 INFO - Display: 05:02:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:02:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:02:56 INFO - Display Serial Number: 1600x1200 60 05:02:56 INFO - Main Display: Yes 05:02:56 INFO - Mirror: Off 05:02:56 INFO - Online: Yes 05:02:56 INFO - Rotation: Supported 05:02:56 INFO - Return code: 0 05:02:56 INFO - Running post-action listener: _resource_record_post_action 05:02:56 INFO - [mozharness: 2017-02-03 13:02:56.416489Z] Finished run-tests step (success) 05:02:56 INFO - Running post-run listener: _resource_record_post_run 05:02:56 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 28094464; Write bytes: 512585728; Read time: 262; Write time: 2013 05:02:56 INFO - TinderboxPrint: CPU usage
54.4% 05:02:56 INFO - TinderboxPrint: I/O read bytes / time
28,094,464 / 262 05:02:56 INFO - TinderboxPrint: I/O write bytes / time
512,585,728 / 2,013 05:02:56 INFO - TinderboxPrint: CPU idle
2,183.3 (45.6%) 05:02:56 INFO - TinderboxPrint: CPU system
966.5 (20.2%) 05:02:56 INFO - TinderboxPrint: CPU user
1,635.8 (34.2%) 05:02:56 INFO - TinderboxPrint: Swap in / out
228,900,864 / 0 05:02:56 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205097472; Write bytes: 201967616; Read time: 15735; Write time: 805 05:02:56 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 27910144; Write bytes: 299538432; Read time: 260; Write time: 1170 05:02:56 INFO - Running post-run listener: _upload_blobber_files 05:02:56 INFO - Blob upload gear active. 05:02:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:02:56 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 05:02:56 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'] 05:02:56 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 05:02:57 INFO - (blobuploader) - INFO - Open directory for files ... 05:02:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:02:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:02:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:58 INFO - (blobuploader) - INFO - Done attempting. 05:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:02:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:59 INFO - (blobuploader) - INFO - Done attempting. 05:02:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:02:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:00 INFO - (blobuploader) - INFO - Done attempting. 05:03:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:03:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:03:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:03 INFO - (blobuploader) - INFO - Done attempting. 05:03:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:03 INFO - Return code: 0 05:03:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4b8a178e68f84b2c947509ca43efe6c14e70ab04b7e6a326fee2ce3cb1937d0baf7370333e8e3134ded731df15410241698f61e36cfdde005c26179f9b25e1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d844b8be092e7c8ce79616db68bc4d7892515b93c1415777a4a63702312bcf69c43d1595e072bae5a59ea1387e26318d4fa205131b8116837409a1e2cdf8d7a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/814c43553657a2653df6cfa5d4f638ab64dca9601218e3823f1c19e014d08bfe481ab2c5bb522bde8c782a0a843ad5b7f0980d519f4bb6562823f2343538bfa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4b673e006a3cf50ba691ecccf450382eed8a1d9d5e6b24e3e3aa4c777611c4d711199da896141b8aebcb092087622132d1ec1ab2ad61186190188799b9bfd83"} 05:03:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:03 INFO - Contents: 05:03:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4b8a178e68f84b2c947509ca43efe6c14e70ab04b7e6a326fee2ce3cb1937d0baf7370333e8e3134ded731df15410241698f61e36cfdde005c26179f9b25e1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d844b8be092e7c8ce79616db68bc4d7892515b93c1415777a4a63702312bcf69c43d1595e072bae5a59ea1387e26318d4fa205131b8116837409a1e2cdf8d7a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/814c43553657a2653df6cfa5d4f638ab64dca9601218e3823f1c19e014d08bfe481ab2c5bb522bde8c782a0a843ad5b7f0980d519f4bb6562823f2343538bfa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4b673e006a3cf50ba691ecccf450382eed8a1d9d5e6b24e3e3aa4c777611c4d711199da896141b8aebcb092087622132d1ec1ab2ad61186190188799b9bfd83"} 05:03:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:03 INFO - Copying logs to upload dir... 05:03:03 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.301731 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-02-03 05:03:03.317538) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 05:03:03.320664) ========= 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.4DR0w2LDuG/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.FEVT5opzjC/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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/a4b8a178e68f84b2c947509ca43efe6c14e70ab04b7e6a326fee2ce3cb1937d0baf7370333e8e3134ded731df15410241698f61e36cfdde005c26179f9b25e1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d844b8be092e7c8ce79616db68bc4d7892515b93c1415777a4a63702312bcf69c43d1595e072bae5a59ea1387e26318d4fa205131b8116837409a1e2cdf8d7a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/814c43553657a2653df6cfa5d4f638ab64dca9601218e3823f1c19e014d08bfe481ab2c5bb522bde8c782a0a843ad5b7f0980d519f4bb6562823f2343538bfa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4b673e006a3cf50ba691ecccf450382eed8a1d9d5e6b24e3e3aa4c777611c4d711199da896141b8aebcb092087622132d1ec1ab2ad61186190188799b9bfd83"} build_url:https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011585 build_url: 'https://queue.taskcluster.net/v1/task/efsS41f7QK--zOaCZIGXxQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4b8a178e68f84b2c947509ca43efe6c14e70ab04b7e6a326fee2ce3cb1937d0baf7370333e8e3134ded731df15410241698f61e36cfdde005c26179f9b25e1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d844b8be092e7c8ce79616db68bc4d7892515b93c1415777a4a63702312bcf69c43d1595e072bae5a59ea1387e26318d4fa205131b8116837409a1e2cdf8d7a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/814c43553657a2653df6cfa5d4f638ab64dca9601218e3823f1c19e014d08bfe481ab2c5bb522bde8c782a0a843ad5b7f0980d519f4bb6562823f2343538bfa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4b673e006a3cf50ba691ecccf450382eed8a1d9d5e6b24e3e3aa4c777611c4d711199da896141b8aebcb092087622132d1ec1ab2ad61186190188799b9bfd83"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 05:03:03.358488) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:03:03.358827) ========= 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.4DR0w2LDuG/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.FEVT5opzjC/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.005643 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:03:03.407025) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 05:03:03.408203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 05:03:03.408532) ========= ========= Total master_lag: 0.21 =========