JUnit version 4.13.2
.03:07:03.509 [DEBUG - main] (TestNegotiationTLSv13.java:108) enabled TLS protocols: TLSv1.3 TLSv1.2 TLSv1.1 TLSv1
03:07:03.512 [DEBUG - main] (TestNegotiationTLSv13.java:110) supported TLS protocols: TLSv1.3 TLSv1.2 SSLv3 TLSv1.1 SSLv2Hello TLSv1
03:07:03.520 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskZjwQ17/test-tmp
03:07:03.522 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
03:07:03.525 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskZjwQ17/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
03:07:03.784 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 0
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766"
  extra_master_flags: "--time_source=system_unsync"
  extra_master_flags: "--rpc_tls_min_protocol=TLSv1.3"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

03:07:03.798 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
03:07:03.799 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

03:07:03.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.800813 27031 mini_oidc.cc:152] Starting JWKS server
03:07:03.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.803323 27031 webserver.cc:460] Webserver started at http://127.0.0.1:46821/ using document root <none> and password file <none>
03:07:03.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.803535 27031 mini_oidc.cc:189] Starting OIDC Discovery server
03:07:03.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.803891 27031 webserver.cc:460] Webserver started at http://127.0.0.1:37841/ using document root <none> and password file <none>
03:07:03.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T03:07:03Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
03:07:03.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T03:07:03Z Disabled control of system clock
03:07:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.822321 27031 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu
03:07:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu
03:07:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/wal
03:07:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/data
03:07:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
03:07:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
03:07:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
03:07:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
03:07:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
03:07:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
03:07:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/logs
03:07:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/data/info.pb
03:07:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
03:07:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
03:07:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
03:07:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
03:07:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
03:07:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
03:07:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
03:07:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
03:07:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.101.254:44125
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.101.254
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.101.212:46849
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.101.254:44125
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46821/jwks.json
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
03:07:03.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3 with env {}
03:07:03.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.943581 27045 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
03:07:03.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.943938 27045 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
03:07:03.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.943984 27045 flags.cc:425] Enabled unsafe flag: --never_fsync=true
03:07:03.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.948647 27045 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
03:07:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.948727 27045 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
03:07:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.948747 27045 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
03:07:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.948763 27045 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
03:07:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.948781 27045 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
03:07:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.948794 27045 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:46821/jwks.json
03:07:03.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.954622 27045 master_runner.cc:386] Master server non-default flags:
03:07:03.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
03:07:03.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.101.212:46849
03:07:03.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
03:07:03.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/data
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/wal
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.101.254:44125
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.101.254:44125
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
03:07:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46821/jwks.json
03:07:03.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3
03:07:03.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
03:07:03.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
03:07:03.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/data/info.pb
03:07:03.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.101.254
03:07:03.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
03:07:03.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
03:07:03.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.27045
03:07:03.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
03:07:03.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
03:07:03.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
03:07:03.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
03:07:03.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/logs
03:07:03.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
03:07:03.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
03:07:03.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
03:07:03.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
03:07:03.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
03:07:03.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
03:07:03.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
03:07:03.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 12 Aug 2026 02:22:35 UTC on ccycloud.quasar-gitnpj.root.comops.site
03:07:03.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581827
03:07:03.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.956262 27045 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
03:07:03.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.957890 27045 file_cache.cc:493] Constructed file cache file cache with capacity 419430
03:07:03.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.967734 27055 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:03.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.967787 27052 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:03.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.967734 27051 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:03.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.968120 27045 server_base.cc:1034] running on GCE node
03:07:03.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.969230 27045 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
03:07:03.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:03.969338 27045 system_unsync_time.cc:38] NTP support is disabled. Clock error bounds will not be accurate. This configuration is not suitable for distributed clusters.
03:07:03.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.969380 27045 hybrid_clock.cc:648] HybridClock initialized: now 1786504023969376 us; error 0 us; skew 500 ppm
03:07:03.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.972414 27045 webserver.cc:460] Webserver started at http://127.26.101.254:42295/ using document root <none> and password file <none>
03:07:03.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.973031 27045 fs_manager.cc:359] Metadata directory not provided
03:07:03.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.973115 27045 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
03:07:03.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.973341 27045 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
03:07:03.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.975878 27045 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/data/instance:
03:07:03.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6e27d7dda96a46f4902a5031f35a42bd"
03:07:03.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:03 on dist-test-slave-wl2h"
03:07:03.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.976668 27045 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/wal/instance:
03:07:03.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6e27d7dda96a46f4902a5031f35a42bd"
03:07:03.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:03 on dist-test-slave-wl2h"
03:07:03.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.981355 27045 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.001s	sys 0.004s
03:07:03.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.984175 27063 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
03:07:03.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.985755 27045 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
03:07:03.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.985877 27045 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/data,/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/wal
03:07:03.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6e27d7dda96a46f4902a5031f35a42bd"
03:07:03.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:03 on dist-test-slave-wl2h"
03:07:03.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:03.985970 27045 fs_report.cc:383] FS layout report
03:07:03.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
03:07:03.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/wal
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/wal
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster1844583263306157766/master-0/data/data
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
03:07:03.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
03:07:03.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
03:07:04.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Invalid argument: invalid minimum TLS protocol version (--rpc_tls_min_protocol): this platform does not support TLSv1.3
03:07:04.025 [DEBUG - main] (MiniKuduCluster.java:195) Response: error {
  code: RUNTIME_ERROR
  message: "failed to start masters: Unable to start Master at index 0: /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu: process exited with non-zero status 1"
}

03:07:04.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T03:07:04Z chronyd exiting
03:07:04.069 [INFO - main] (TestNegotiationTLSv13.java:145) server side doesn't support TLSv1.3
java.io.IOException: failed to start masters: Unable to start Master at index 0: /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu: process exited with non-zero status 1
	at org.apache.kudu.test.cluster.MiniKuduCluster.sendRequestToCluster(MiniKuduCluster.java:199) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster.start(MiniKuduCluster.java:266) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster.access$300(MiniKuduCluster.java:85) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster$MiniKuduClusterBuilder.build(MiniKuduCluster.java:883) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.client.TestNegotiationTLSv13.isTLSv13SupportedByServerSide(TestNegotiationTLSv13.java:133) [test/:?]
	at org.apache.kudu.client.TestNegotiationTLSv13.<init>(TestNegotiationTLSv13.java:157) [test/:?]
	at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_362]
	at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) [?:1.8.0_362]
	at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) [?:1.8.0_362]
	at java.lang.reflect.Constructor.newInstance(Constructor.java:423) [?:1.8.0_362]
	at org.junit.runners.BlockJUnit4ClassRunner.createTest(BlockJUnit4ClassRunner.java:250) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.createTest(BlockJUnit4ClassRunner.java:260) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner$2.runReflectiveCall(BlockJUnit4ClassRunner.java:309) [junit-4.13.2.jar:4.13.2]
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.methodBlock(BlockJUnit4ClassRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.Suite.runChild(Suite.java:128) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.Suite.runChild(Suite.java:27) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36) [junit-4.13.2.jar:4.13.2]
03:07:04.079 [INFO - main] (RandomUtils.java:49) Using random seed: 1786504024079
03:07:04.087 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
03:07:04.132 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
03:07:04.133 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskZjwQ17/test-tmp
03:07:04.133 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
03:07:04.133 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskZjwQ17/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
03:07:04.136 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941"
  extra_master_flags: "--rpc-encryption=required"
  extra_master_flags: "--rpc_encrypt_loopback_connections"
  extra_master_flags: "--rpc-trace-negotiation"
  extra_tserver_flags: "--rpc-encryption=required"
  extra_tserver_flags: "--rpc_encrypt_loopback_connections"
  extra_tserver_flags: "--rpc-trace-negotiation"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

03:07:04.253 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
03:07:04.253 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

03:07:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:04.254817 27067 mini_oidc.cc:152] Starting JWKS server
03:07:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:04.256889 27067 webserver.cc:460] Webserver started at http://127.0.0.1:45949/ using document root <none> and password file <none>
03:07:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:04.257025 27067 mini_oidc.cc:189] Starting OIDC Discovery server
03:07:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:04.257263 27067 webserver.cc:460] Webserver started at http://127.0.0.1:43309/ using document root <none> and password file <none>
03:07:04.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
03:07:04.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/principal' for realm 'KRBTEST.COM',
03:07:04.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
03:07:04.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:04 dist-test-slave-wl2h krb5kdc[27080](info): setting up network...
03:07:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
03:07:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:04 dist-test-slave-wl2h krb5kdc[27080](info): set up 2 sockets
03:07:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:04 dist-test-slave-wl2h krb5kdc[27080](info): commencing operation
03:07:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
03:07:05.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.424129 27067 mini_kdc.cc:121] Time spent starting KDC: real 1.160s	user 0.000s	sys 0.008s
03:07:05.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
03:07:05.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
03:07:05.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
03:07:05.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
03:07:05.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
03:07:05.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
03:07:05.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
03:07:05.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
03:07:05.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
03:07:05.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
03:07:05.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal test-user with kvno 1, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/test-user.keytab.
03:07:05.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal test-user with kvno 1, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/test-user.keytab.
03:07:05.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:05 dist-test-slave-wl2h krb5kdc[27080](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786504025, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
03:07:05.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
03:07:05.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T03:07:05Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
03:07:05.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T03:07:05Z Disabled control of system clock
03:07:05.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.26.110.254@KRBTEST.COM; defaulting to no policy
03:07:05.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
03:07:05.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.26.110.254@KRBTEST.COM" created.
03:07:05.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
03:07:05.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.110.254 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.254.keytab.
03:07:05.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.110.254 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.254.keytab.
03:07:05.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.559772 27067 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu
03:07:05.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu
03:07:05.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/wal
03:07:05.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/data
03:07:05.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
03:07:05.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
03:07:05.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
03:07:05.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
03:07:05.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
03:07:05.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
03:07:05.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/logs
03:07:05.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/data/info.pb
03:07:05.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
03:07:05.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.110.254:42815
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.110.254
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.254.keytab
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.110.254
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
03:07:05.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.110.212:45225
03:07:05.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
03:07:05.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
03:07:05.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
03:07:05.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
03:07:05.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.110.254:42815
03:07:05.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
03:07:05.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45949/jwks.json
03:07:05.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
03:07:05.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
03:07:05.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
03:07:05.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.680059 27099 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
03:07:05.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.680357 27099 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
03:07:05.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.680405 27099 flags.cc:425] Enabled unsafe flag: --never_fsync=true
03:07:05.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.684868 27099 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
03:07:05.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.684952 27099 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
03:07:05.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.684971 27099 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
03:07:05.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.684989 27099 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
03:07:05.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.685006 27099 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
03:07:05.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.685024 27099 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
03:07:05.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.685036 27099 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45949/jwks.json
03:07:05.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.690891 27099 master_runner.cc:386] Master server non-default flags:
03:07:05.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
03:07:05.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.110.212:45225
03:07:05.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
03:07:05.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
03:07:05.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/data
03:07:05.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/wal
03:07:05.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.110.254:42815
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.254.keytab
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.110.254
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.110.254:42815
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
03:07:05.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
03:07:05.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45949/jwks.json
03:07:05.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
03:07:05.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/data/info.pb
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.110.254
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.27099
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/logs
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
03:07:05.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
03:07:05.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
03:07:05.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
03:07:05.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
03:07:05.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 12 Aug 2026 02:22:35 UTC on ccycloud.quasar-gitnpj.root.comops.site
03:07:05.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581827
03:07:05.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.692075 27099 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
03:07:05.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.693428 27099 file_cache.cc:493] Constructed file cache file cache with capacity 419430
03:07:05.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.702901 27106 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:05.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.702937 27107 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:05.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:05.702951 27109 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:05.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.703474 27099 server_base.cc:1034] running on GCE node
03:07:05.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.704118 27099 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
03:07:05.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.705336 27099 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
03:07:05.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.706566 27099 hybrid_clock.cc:648] HybridClock initialized: now 1786504025706485 us; error 97 us; skew 500 ppm
03:07:05.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:05 dist-test-slave-wl2h krb5kdc[27080](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786504025, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.110.254@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
03:07:05.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.709710 27099 init.cc:377] Logged in from keytab as kudu/127.26.110.254@KRBTEST.COM (short username kudu)
03:07:05.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.710846 27099 webserver.cc:460] Webserver started at http://127.26.110.254:36501/ using document root <none> and password file <none>
03:07:05.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.711541 27099 fs_manager.cc:359] Metadata directory not provided
03:07:05.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.711649 27099 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
03:07:05.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.711932 27099 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
03:07:05.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.714061 27099 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/data/instance:
03:07:05.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ca23c5c5a70e4c26a6834be3de0b9e00"
03:07:05.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:05 on dist-test-slave-wl2h"
03:07:05.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.714718 27099 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/wal/instance:
03:07:05.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ca23c5c5a70e4c26a6834be3de0b9e00"
03:07:05.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:05 on dist-test-slave-wl2h"
03:07:05.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.719058 27099 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.002s	sys 0.001s
03:07:05.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.721763 27117 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
03:07:05.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.723249 27099 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
03:07:05.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.723395 27099 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/data,/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/wal
03:07:05.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ca23c5c5a70e4c26a6834be3de0b9e00"
03:07:05.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:05 on dist-test-slave-wl2h"
03:07:05.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.723513 27099 fs_report.cc:383] FS layout report
03:07:05.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
03:07:05.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/wal
03:07:05.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/wal
03:07:05.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/data/data
03:07:05.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
03:07:05.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
03:07:05.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
03:07:05.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
03:07:05.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
03:07:05.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
03:07:05.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
03:07:05.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
03:07:05.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
03:07:05.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
03:07:05.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
03:07:05.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.734498 27099 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
03:07:05.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.738205 27099 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
03:07:05.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.738438 27099 kserver.cc:163] Server-wide thread pool size limit: 3276
03:07:05.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.745887 27099 rpc_server.cc:307] RPC server started. Bound to: 127.26.110.254:42815
03:07:05.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.746212 27183 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.26.110.254:42815 every 8 connection(s)
03:07:05.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.747066 27099 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/data/info.pb
03:07:05.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.748023 27067 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu as pid 27099
03:07:05.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.748164 27067 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/master-0/wal/instance
03:07:05.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.750190 27184 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
03:07:05.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.756441 27184 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00: Bootstrap starting.
03:07:05.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.759223 27184 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00: Neither blocks nor log segments found. Creating new log.
03:07:05.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.760087 27184 log.cc:824] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00: Log is configured to *not* fsync() on all Append() calls
03:07:05.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.762226 27184 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00: No bootstrap required, opened a new log
03:07:05.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:05 dist-test-slave-wl2h krb5kdc[27080](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786504025, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.26.110.254@KRBTEST.COM
03:07:05.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.766377 27184 raft_consensus.cc:348] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca23c5c5a70e4c26a6834be3de0b9e00" member_type: VOTER last_known_addr { host: "127.26.110.254" port: 42815 } }
03:07:05.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.766732 27184 raft_consensus.cc:374] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
03:07:05.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.766793 27184 raft_consensus.cc:729] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ca23c5c5a70e4c26a6834be3de0b9e00, State: Initialized, Role: FOLLOWER
03:07:05.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.767416 27184 consensus_queue.cc:260] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca23c5c5a70e4c26a6834be3de0b9e00" member_type: VOTER last_known_addr { host: "127.26.110.254" port: 42815 } }
03:07:05.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.767607 27184 raft_consensus.cc:388] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
03:07:05.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.767679 27184 raft_consensus.cc:482] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
03:07:05.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.767783 27184 raft_consensus.cc:3037] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [term 0 FOLLOWER]: Advancing to term 1
03:07:05.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.769166 27184 raft_consensus.cc:504] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca23c5c5a70e4c26a6834be3de0b9e00" member_type: VOTER last_known_addr { host: "127.26.110.254" port: 42815 } }
03:07:05.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.769613 27184 leader_election.cc:302] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: ca23c5c5a70e4c26a6834be3de0b9e00; no voters: 
03:07:05.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.770002 27184 leader_election.cc:288] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [CANDIDATE]: Term 1 election: Requested vote from peers 
03:07:05.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.771251 27192 raft_consensus.cc:2781] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [term 1 FOLLOWER]: Leader election won for term 1
03:07:05.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.771446 27184 sys_catalog.cc:564] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [sys.catalog]: configured and running, proceeding with master startup.
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.773145 27187 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.751511 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.0.0.1:53068 (local address 127.26.110.254:42815)
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.752142 (+   631us) server_negotiation.cc:206] Beginning negotiation
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.752161 (+    19us) server_negotiation.cc:399] Waiting for connection header
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.752760 (+   599us) server_negotiation.cc:407] Connection header received
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.754646 (+  1886us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.754666 (+    20us) server_negotiation.cc:461] Received NEGOTIATE request from client
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.755082 (+   416us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.755428 (+   346us) server_negotiation.cc:226] Negotiated authn=SASL
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.757340 (+  1912us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.758827 (+  1487us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.760191 (+  1364us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.760801 (+   610us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.761004 (+   203us) server_negotiation.cc:662] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.765485 (+  4481us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.765492 (+     7us) server_negotiation.cc:881] Received SASL_INITIATE request from client
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.765508 (+    16us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.765545 (+    37us) server_negotiation.cc:922] calling sasl_server_start()
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.768062 (+  2517us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.768891 (+   829us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.768898 (+     7us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
03:07:05.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.768905 (+     7us) server_negotiation.cc:967] calling sasl_server_step()
03:07:05.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.769076 (+   171us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
03:07:05.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.769685 (+   609us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
03:07:05.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.769689 (+     4us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
03:07:05.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.769691 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
03:07:05.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.770273 (+   582us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
03:07:05.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.770493 (+   220us) server_negotiation.cc:1035] Waiting for connection context
03:07:05.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.771994 (+  1501us) server_negotiation.cc:299] Negotiation successful
03:07:05.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:05.772214 (+   220us) negotiation.cc:327] Negotiation complete: OK
03:07:05.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":465,"thread_start_us":155,"threads_started":1}
03:07:05.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.775940 27192 raft_consensus.cc:686] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [term 1 LEADER]: Becoming Leader. State: Replica: ca23c5c5a70e4c26a6834be3de0b9e00, State: Running, Role: LEADER
03:07:05.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.776494 27192 consensus_queue.cc:237] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca23c5c5a70e4c26a6834be3de0b9e00" member_type: VOTER last_known_addr { host: "127.26.110.254" port: 42815 } }
03:07:05.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.778023 27192 sys_catalog.cc:455] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [sys.catalog]: SysCatalogTable state changed. Reason: New leader ca23c5c5a70e4c26a6834be3de0b9e00. Latest consensus state: current_term: 1 leader_uuid: "ca23c5c5a70e4c26a6834be3de0b9e00" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca23c5c5a70e4c26a6834be3de0b9e00" member_type: VOTER last_known_addr { host: "127.26.110.254" port: 42815 } } }
03:07:05.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.778470 27192 sys_catalog.cc:458] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [sys.catalog]: This master's current role is: LEADER
03:07:05.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.778578 27193 sys_catalog.cc:455] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "ca23c5c5a70e4c26a6834be3de0b9e00" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca23c5c5a70e4c26a6834be3de0b9e00" member_type: VOTER last_known_addr { host: "127.26.110.254" port: 42815 } } }
03:07:05.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.778741 27193 sys_catalog.cc:458] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00 [sys.catalog]: This master's current role is: LEADER
03:07:05.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.779167 27211 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
03:07:05.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.782716 27211 catalog_manager.cc:1484] Initializing Kudu cluster ID...
03:07:05.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.789003 27211 catalog_manager.cc:1347] Generated new cluster ID: 29e08ec5177e4eaabb7803c0d6bde111
03:07:05.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.789098 27211 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
03:07:05.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.810406 27211 catalog_manager.cc:1370] Generated new certificate authority record
03:07:05.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.811439 27211 catalog_manager.cc:1504] Loading token signing keys...
03:07:05.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.826604 27211 catalog_manager.cc:5868] T 00000000000000000000000000000000 P ca23c5c5a70e4c26a6834be3de0b9e00: Generated new TSK 0
03:07:05.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.827577 27211 catalog_manager.cc:1514] Initializing in-progress tserver states...
03:07:05.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.26.110.193@KRBTEST.COM; defaulting to no policy
03:07:05.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
03:07:05.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.26.110.193@KRBTEST.COM" created.
03:07:05.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
03:07:05.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.110.193 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.193.keytab.
03:07:05.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.110.193 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.193.keytab.
03:07:05.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:05.871573 27067 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu
03:07:05.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu
03:07:05.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/wal
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/data
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/logs
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/data/info.pb
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
03:07:05.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.110.193:0
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.110.193
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.110.193
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.110.254:42815
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.193.keytab
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.110.193
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.110.212:45225
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
03:07:05.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
03:07:06.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.016445 27219 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
03:07:06.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.016765 27219 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
03:07:06.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.016814 27219 flags.cc:425] Enabled unsafe flag: --never_fsync=true
03:07:06.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.021142 27219 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
03:07:06.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.021219 27219 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
03:07:06.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.021281 27219 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.110.193
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.026896 27219 tablet_server_runner.cc:78] Tablet server non-default flags:
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.110.212:45225
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/data
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/wal
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.193.keytab
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.110.193
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
03:07:06.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.110.193:0
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/data/info.pb
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.110.193
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.110.254:42815
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.27219
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.110.193
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/logs
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
03:07:06.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
03:07:06.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
03:07:06.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
03:07:06.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
03:07:06.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
03:07:06.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 12 Aug 2026 02:22:35 UTC on ccycloud.quasar-gitnpj.root.comops.site
03:07:06.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581827
03:07:06.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.028205 27219 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
03:07:06.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.029438 27219 file_cache.cc:493] Constructed file cache file cache with capacity 419430
03:07:06.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.040977 27227 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:06.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.040999 27229 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:06.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.041054 27226 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:06.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.041380 27219 server_base.cc:1034] running on GCE node
03:07:06.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.041790 27219 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
03:07:06.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.042598 27219 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
03:07:06.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.043835 27219 hybrid_clock.cc:648] HybridClock initialized: now 1786504026043804 us; error 41 us; skew 500 ppm
03:07:06.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:06 dist-test-slave-wl2h krb5kdc[27080](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786504026, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.110.193@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
03:07:06.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.046970 27219 init.cc:377] Logged in from keytab as kudu/127.26.110.193@KRBTEST.COM (short username kudu)
03:07:06.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.048058 27219 webserver.cc:460] Webserver started at http://127.26.110.193:45179/ using document root <none> and password file <none>
03:07:06.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.048779 27219 fs_manager.cc:359] Metadata directory not provided
03:07:06.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.048849 27219 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
03:07:06.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.049080 27219 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
03:07:06.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.051240 27219 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/data/instance:
03:07:06.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "85961dc8eaf3421589eba2a04c34951e"
03:07:06.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:06 on dist-test-slave-wl2h"
03:07:06.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.051908 27219 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/wal/instance:
03:07:06.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "85961dc8eaf3421589eba2a04c34951e"
03:07:06.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:06 on dist-test-slave-wl2h"
03:07:06.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.056063 27219 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
03:07:06.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.058631 27238 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
03:07:06.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.060220 27219 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
03:07:06.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.060376 27219 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/data,/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/wal
03:07:06.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "85961dc8eaf3421589eba2a04c34951e"
03:07:06.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:06 on dist-test-slave-wl2h"
03:07:06.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.060497 27219 fs_report.cc:383] FS layout report
03:07:06.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
03:07:06.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/wal
03:07:06.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/wal
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/data/data
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
03:07:06.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
03:07:06.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.078220 27219 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
03:07:06.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.081482 27219 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
03:07:06.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.081717 27219 kserver.cc:163] Server-wide thread pool size limit: 3276
03:07:06.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.082418 27219 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
03:07:06.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.083397 27219 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
03:07:06.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.083472 27219 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
03:07:06.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.083536 27219 ts_tablet_manager.cc:610] Registered 0 tablets
03:07:06.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.083561 27219 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
03:07:06.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.093040 27219 rpc_server.cc:307] RPC server started. Bound to: 127.26.110.193:35161
03:07:06.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.093068 27382 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.26.110.193:35161 every 8 connection(s)
03:07:06.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.093943 27219 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/data/info.pb
03:07:06.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.100221 27067 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu as pid 27219
03:07:06.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.100317 27067 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-0/wal/instance
03:07:06.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:06 dist-test-slave-wl2h krb5kdc[27080](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786504026, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.110.193@KRBTEST.COM for kudu/127.26.110.254@KRBTEST.COM
03:07:06.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.110026 27187 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
03:07:06.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.096060 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.26.110.193:35847 (local address 127.26.110.254:42815)
03:07:06.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.096240 (+   180us) server_negotiation.cc:206] Beginning negotiation
03:07:06.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.096246 (+     6us) server_negotiation.cc:399] Waiting for connection header
03:07:06.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.097147 (+   901us) server_negotiation.cc:407] Connection header received
03:07:06.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.098655 (+  1508us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
03:07:06.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.098658 (+     3us) server_negotiation.cc:461] Received NEGOTIATE request from client
03:07:06.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.098708 (+    50us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
03:07:06.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.098786 (+    78us) server_negotiation.cc:226] Negotiated authn=SASL
03:07:06.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.100024 (+  1238us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
03:07:06.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.100773 (+   749us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
03:07:06.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.102193 (+  1420us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
03:07:06.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.102412 (+   219us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.102494 (+    82us) server_negotiation.cc:662] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.105533 (+  3039us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.105536 (+     3us) server_negotiation.cc:881] Received SASL_INITIATE request from client
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.105538 (+     2us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.105586 (+    48us) server_negotiation.cc:922] calling sasl_server_start()
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.107601 (+  2015us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108221 (+   620us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108228 (+     7us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108233 (+     5us) server_negotiation.cc:967] calling sasl_server_step()
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108332 (+    99us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108739 (+   407us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108744 (+     5us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108749 (+     5us) server_negotiation.cc:967] calling sasl_server_step()
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.109027 (+   278us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
03:07:06.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.109184 (+   157us) server_negotiation.cc:1035] Waiting for connection context
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.109690 (+   506us) server_negotiation.cc:299] Negotiation successful
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.109824 (+   134us) negotiation.cc:327] Negotiation complete: OK
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":71}
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.110803 27387 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.096499 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.26.110.254:42815 (local address 127.26.110.193:35847)
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.096981 (+   482us) negotiation.cc:107] Waiting for socket to connect
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.097025 (+    44us) client_negotiation.cc:174] Beginning negotiation
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.098425 (+  1400us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.098948 (+   523us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.098954 (+     6us) client_negotiation.cc:394] Received NEGOTIATE response from server
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.099398 (+   444us) client_negotiation.cc:189] Negotiated authn=SASL
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.099862 (+   464us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.099873 (+    11us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.100933 (+  1060us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.100936 (+     3us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.102043 (+  1107us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.102051 (+     8us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.102571 (+   520us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
03:07:06.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.102578 (+     7us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
03:07:06.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.102815 (+   237us) client_negotiation.cc:553] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
03:07:06.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.103622 (+   807us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
03:07:06.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.103648 (+    26us) client_negotiation.cc:656] calling sasl_client_start()
03:07:06.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.105319 (+  1671us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
03:07:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.107790 (+  2471us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
03:07:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.107795 (+     5us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
03:07:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.107808 (+    13us) client_negotiation.cc:760] calling sasl_client_step()
03:07:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108072 (+   264us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
03:07:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108460 (+   388us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
03:07:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108462 (+     2us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
03:07:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108463 (+     1us) client_negotiation.cc:760] calling sasl_client_step()
03:07:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.108600 (+   137us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
03:07:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.109174 (+   574us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
03:07:06.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.109179 (+     5us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
03:07:06.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.109418 (+   239us) client_negotiation.cc:769] Sending connection context
03:07:06.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.109592 (+   174us) client_negotiation.cc:240] Negotiation successful
03:07:06.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.109789 (+   197us) negotiation.cc:327] Negotiation complete: OK
03:07:06.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":283,"thread_start_us":109,"threads_started":1}
03:07:06.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.26.110.194@KRBTEST.COM; defaulting to no policy
03:07:06.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.112371 27384 heartbeater.cc:347] Connected to a master server at 127.26.110.254:42815
03:07:06.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.112591 27384 heartbeater.cc:464] Registering TS with master...
03:07:06.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.113087 27384 heartbeater.cc:511] Master 127.26.110.254:42815 requested a full tablet report, sending...
03:07:06.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
03:07:06.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.26.110.194@KRBTEST.COM" created.
03:07:06.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.114854 27138 ts_manager.cc:194] Registered new tserver with Master: 85961dc8eaf3421589eba2a04c34951e (127.26.110.193:35161)
03:07:06.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.116475 27138 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.26.110.193@KRBTEST.COM'} at 127.26.110.193:35847
03:07:06.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
03:07:06.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.110.194 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.194.keytab.
03:07:06.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.110.194 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.194.keytab.
03:07:06.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.134641 27067 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu
03:07:06.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/wal
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/data
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/logs
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/data/info.pb
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
03:07:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.110.194:0
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.110.194
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.110.194
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.110.254:42815
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.194.keytab
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.110.194
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
03:07:06.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.110.212:45225
03:07:06.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
03:07:06.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
03:07:06.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
03:07:06.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
03:07:06.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
03:07:06.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
03:07:06.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.250257 27392 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
03:07:06.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.250541 27392 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
03:07:06.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.250587 27392 flags.cc:425] Enabled unsafe flag: --never_fsync=true
03:07:06.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.255162 27392 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
03:07:06.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.255245 27392 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
03:07:06.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.255312 27392 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.110.194
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.260893 27392 tablet_server_runner.cc:78] Tablet server non-default flags:
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.110.212:45225
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/data
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/wal
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.194.keytab
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.110.194
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.110.194:0
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
03:07:06.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/data/info.pb
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.110.194
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.110.254:42815
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.27392
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.110.194
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/logs
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
03:07:06.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
03:07:06.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 12 Aug 2026 02:22:35 UTC on ccycloud.quasar-gitnpj.root.comops.site
03:07:06.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581827
03:07:06.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.262377 27392 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
03:07:06.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.263760 27392 file_cache.cc:493] Constructed file cache file cache with capacity 419430
03:07:06.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.274745 27401 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:06.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.274766 27405 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:06.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.274758 27402 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:06.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.275553 27392 server_base.cc:1034] running on GCE node
03:07:06.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.276015 27392 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
03:07:06.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.276687 27392 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
03:07:06.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.277901 27392 hybrid_clock.cc:648] HybridClock initialized: now 1786504026277881 us; error 34 us; skew 500 ppm
03:07:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:06 dist-test-slave-wl2h krb5kdc[27080](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786504026, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.110.194@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
03:07:06.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.281119 27392 init.cc:377] Logged in from keytab as kudu/127.26.110.194@KRBTEST.COM (short username kudu)
03:07:06.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.282184 27392 webserver.cc:460] Webserver started at http://127.26.110.194:32913/ using document root <none> and password file <none>
03:07:06.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.282814 27392 fs_manager.cc:359] Metadata directory not provided
03:07:06.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.282917 27392 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
03:07:06.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.283226 27392 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
03:07:06.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.285262 27392 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/data/instance:
03:07:06.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c0bb7caa14684ff08e4108cf9e1413b1"
03:07:06.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:06 on dist-test-slave-wl2h"
03:07:06.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.285931 27392 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/wal/instance:
03:07:06.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c0bb7caa14684ff08e4108cf9e1413b1"
03:07:06.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:06 on dist-test-slave-wl2h"
03:07:06.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.289968 27392 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.002s	sys 0.004s
03:07:06.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.292838 27415 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
03:07:06.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.294324 27392 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
03:07:06.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.294492 27392 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/data,/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/wal
03:07:06.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c0bb7caa14684ff08e4108cf9e1413b1"
03:07:06.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:06 on dist-test-slave-wl2h"
03:07:06.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.294617 27392 fs_report.cc:383] FS layout report
03:07:06.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/wal
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/wal
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/data/data
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
03:07:06.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
03:07:06.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.318382 27392 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
03:07:06.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.321596 27392 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
03:07:06.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.321834 27392 kserver.cc:163] Server-wide thread pool size limit: 3276
03:07:06.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.322520 27392 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
03:07:06.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.323429 27392 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
03:07:06.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.323504 27392 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
03:07:06.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.323562 27392 ts_tablet_manager.cc:610] Registered 0 tablets
03:07:06.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.323585 27392 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
03:07:06.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.333966 27392 rpc_server.cc:307] RPC server started. Bound to: 127.26.110.194:34209
03:07:06.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.334131 27557 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.26.110.194:34209 every 8 connection(s)
03:07:06.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.335000 27392 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/data/info.pb
03:07:06.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.342940 27067 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu as pid 27392
03:07:06.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.343077 27067 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-1/wal/instance
03:07:06.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:06 dist-test-slave-wl2h krb5kdc[27080](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786504026, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.110.194@KRBTEST.COM for kudu/127.26.110.254@KRBTEST.COM
03:07:06.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.351656 27187 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
03:07:06.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.337247 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.26.110.194:53547 (local address 127.26.110.254:42815)
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.337418 (+   171us) server_negotiation.cc:206] Beginning negotiation
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.337423 (+     5us) server_negotiation.cc:399] Waiting for connection header
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.338353 (+   930us) server_negotiation.cc:407] Connection header received
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.340231 (+  1878us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.340234 (+     3us) server_negotiation.cc:461] Received NEGOTIATE request from client
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.340284 (+    50us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.340350 (+    66us) server_negotiation.cc:226] Negotiated authn=SASL
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.341911 (+  1561us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.342463 (+   552us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.344015 (+  1552us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.344273 (+   258us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.344361 (+    88us) server_negotiation.cc:662] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.347522 (+  3161us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.347526 (+     4us) server_negotiation.cc:881] Received SASL_INITIATE request from client
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.347528 (+     2us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.347553 (+    25us) server_negotiation.cc:922] calling sasl_server_start()
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.349079 (+  1526us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.349850 (+   771us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.349853 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.349854 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.349930 (+    76us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.350414 (+   484us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.350417 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.350418 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.350589 (+   171us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.350682 (+    93us) server_negotiation.cc:1035] Waiting for connection context
03:07:06.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.351453 (+   771us) server_negotiation.cc:299] Negotiation successful
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.351531 (+    78us) negotiation.cc:327] Negotiation complete: OK
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":60}
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.352847 27560 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.337622 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.26.110.254:42815 (local address 127.26.110.194:53547)
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.338153 (+   531us) negotiation.cc:107] Waiting for socket to connect
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.338223 (+    70us) client_negotiation.cc:174] Beginning negotiation
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.339980 (+  1757us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.340537 (+   557us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.340546 (+     9us) client_negotiation.cc:394] Received NEGOTIATE response from server
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.341078 (+   532us) client_negotiation.cc:189] Negotiated authn=SASL
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.341733 (+   655us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.341753 (+    20us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.342598 (+   845us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
03:07:06.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.342601 (+     3us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.343901 (+  1300us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.343910 (+     9us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.344445 (+   535us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.344449 (+     4us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.344639 (+   190us) client_negotiation.cc:553] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.345405 (+   766us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.345427 (+    22us) client_negotiation.cc:656] calling sasl_client_start()
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.347289 (+  1862us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.349297 (+  2008us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.349306 (+     9us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.349324 (+    18us) client_negotiation.cc:760] calling sasl_client_step()
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.349701 (+   377us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.350061 (+   360us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.350067 (+     6us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.350072 (+     5us) client_negotiation.cc:760] calling sasl_client_step()
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.350278 (+   206us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.350742 (+   464us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
03:07:06.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.350752 (+    10us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
03:07:06.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.351143 (+   391us) client_negotiation.cc:769] Sending connection context
03:07:06.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.351401 (+   258us) client_negotiation.cc:240] Negotiation successful
03:07:06.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.351665 (+   264us) negotiation.cc:327] Negotiation complete: OK
03:07:06.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":295,"thread_start_us":120,"threads_started":1}
03:07:06.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.26.110.195@KRBTEST.COM; defaulting to no policy
03:07:06.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.355881 27558 heartbeater.cc:347] Connected to a master server at 127.26.110.254:42815
03:07:06.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.356150 27558 heartbeater.cc:464] Registering TS with master...
03:07:06.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.356762 27558 heartbeater.cc:511] Master 127.26.110.254:42815 requested a full tablet report, sending...
03:07:06.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
03:07:06.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.26.110.195@KRBTEST.COM" created.
03:07:06.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.357987 27138 ts_manager.cc:194] Registered new tserver with Master: c0bb7caa14684ff08e4108cf9e1413b1 (127.26.110.194:34209)
03:07:06.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.358614 27138 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.26.110.194@KRBTEST.COM'} at 127.26.110.194:53547
03:07:06.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
03:07:06.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.110.195 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.195.keytab.
03:07:06.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.110.195 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.195.keytab.
03:07:06.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.375595 27067 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu
03:07:06.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu
03:07:06.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/wal
03:07:06.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/data
03:07:06.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
03:07:06.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
03:07:06.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/logs
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/data/info.pb
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
03:07:06.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.110.195:0
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.110.195
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.110.195
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.110.254:42815
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.195.keytab
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.110.195
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.110.212:45225
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
03:07:06.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
03:07:06.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.500154 27565 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
03:07:06.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.500464 27565 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
03:07:06.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.500516 27565 flags.cc:425] Enabled unsafe flag: --never_fsync=true
03:07:06.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.504786 27565 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
03:07:06.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.504866 27565 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
03:07:06.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.504928 27565 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.110.195
03:07:06.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.510280 27565 tablet_server_runner.cc:78] Tablet server non-default flags:
03:07:06.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
03:07:06.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.110.212:45225
03:07:06.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
03:07:06.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
03:07:06.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/data
03:07:06.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/wal
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kudu_127.26.110.195.keytab
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.110.195
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.110.195:0
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/data/info.pb
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.110.195
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.110.254:42815
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.27565
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.110.195
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/logs
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
03:07:06.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 12 Aug 2026 02:22:35 UTC on ccycloud.quasar-gitnpj.root.comops.site
03:07:06.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581827
03:07:06.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.511549 27565 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
03:07:06.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.512920 27565 file_cache.cc:493] Constructed file cache file cache with capacity 419430
03:07:06.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.524524 27573 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:06.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.524529 27571 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:06.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.524524 27570 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
03:07:06.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.524871 27565 server_base.cc:1034] running on GCE node
03:07:06.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.525494 27565 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
03:07:06.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.526155 27565 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
03:07:06.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.527351 27565 hybrid_clock.cc:648] HybridClock initialized: now 1786504026527326 us; error 54 us; skew 500 ppm
03:07:06.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:06 dist-test-slave-wl2h krb5kdc[27080](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786504026, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.110.195@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
03:07:06.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.530309 27565 init.cc:377] Logged in from keytab as kudu/127.26.110.195@KRBTEST.COM (short username kudu)
03:07:06.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.531297 27565 webserver.cc:460] Webserver started at http://127.26.110.195:39029/ using document root <none> and password file <none>
03:07:06.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.531850 27565 fs_manager.cc:359] Metadata directory not provided
03:07:06.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.531914 27565 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
03:07:06.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.532110 27565 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
03:07:06.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.534003 27565 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/data/instance:
03:07:06.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e5c7728b9611409ba52301d67281fc7c"
03:07:06.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:06 on dist-test-slave-wl2h"
03:07:06.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.534523 27565 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/wal/instance:
03:07:06.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e5c7728b9611409ba52301d67281fc7c"
03:07:06.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:06 on dist-test-slave-wl2h"
03:07:06.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.538285 27565 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.006s	sys 0.000s
03:07:06.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.540729 27584 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.542119 27565 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.000s	sys 0.002s
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.542232 27565 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/data,/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/wal
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e5c7728b9611409ba52301d67281fc7c"
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 03:07:06 on dist-test-slave-wl2h"
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.542313 27565 fs_report.cc:383] FS layout report
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/wal
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/wal
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/data/data
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
03:07:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
03:07:06.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
03:07:06.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.559401 27565 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
03:07:06.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.563836 27565 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
03:07:06.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.564098 27565 kserver.cc:163] Server-wide thread pool size limit: 3276
03:07:06.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.564797 27565 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
03:07:06.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.565730 27565 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
03:07:06.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.565779 27565 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
03:07:06.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.565819 27565 ts_tablet_manager.cc:610] Registered 0 tablets
03:07:06.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.565922 27565 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
03:07:06.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.575976 27565 rpc_server.cc:307] RPC server started. Bound to: 127.26.110.195:35567
03:07:06.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.576010 27733 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.26.110.195:35567 every 8 connection(s)
03:07:06.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.576889 27565 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/data/info.pb
03:07:06.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.577909 27067 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu as pid 27565
03:07:06.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.578023 27067 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/ts-2/wal/instance
03:07:06.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 03:07:06 dist-test-slave-wl2h krb5kdc[27080](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786504026, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.110.195@KRBTEST.COM for kudu/127.26.110.254@KRBTEST.COM
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.593853 27187 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.579364 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.26.110.195:32905 (local address 127.26.110.254:42815)
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.579517 (+   153us) server_negotiation.cc:206] Beginning negotiation
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.579522 (+     5us) server_negotiation.cc:399] Waiting for connection header
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.580652 (+  1130us) server_negotiation.cc:407] Connection header received
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.582332 (+  1680us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.582335 (+     3us) server_negotiation.cc:461] Received NEGOTIATE request from client
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.582381 (+    46us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.582460 (+    79us) server_negotiation.cc:226] Negotiated authn=SASL
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.584414 (+  1954us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.585020 (+   606us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.586462 (+  1442us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.586701 (+   239us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.586807 (+   106us) server_negotiation.cc:662] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.589690 (+  2883us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.589694 (+     4us) server_negotiation.cc:881] Received SASL_INITIATE request from client
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.589696 (+     2us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.589723 (+    27us) server_negotiation.cc:922] calling sasl_server_start()
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.591359 (+  1636us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592056 (+   697us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592061 (+     5us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592063 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592156 (+    93us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592588 (+   432us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592591 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592592 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592826 (+   234us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592936 (+   110us) server_negotiation.cc:1035] Waiting for connection context
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.593647 (+   711us) server_negotiation.cc:299] Negotiation successful
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.593731 (+    84us) negotiation.cc:327] Negotiation complete: OK
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":61}
03:07:06.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.594652 27737 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
03:07:06.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.579900 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.26.110.254:42815 (local address 127.26.110.195:32905)
03:07:06.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.580498 (+   598us) negotiation.cc:107] Waiting for socket to connect
03:07:06.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.580557 (+    59us) client_negotiation.cc:174] Beginning negotiation
03:07:06.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.582062 (+  1505us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
03:07:06.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.582604 (+   542us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
03:07:06.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.582611 (+     7us) client_negotiation.cc:394] Received NEGOTIATE response from server
03:07:06.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.582994 (+   383us) client_negotiation.cc:189] Negotiated authn=SASL
03:07:06.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.584206 (+  1212us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
03:07:06.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.584231 (+    25us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
03:07:06.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.585353 (+  1122us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
03:07:06.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.585356 (+     3us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.586330 (+   974us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.586340 (+    10us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.586897 (+   557us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.586901 (+     4us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.587109 (+   208us) client_negotiation.cc:553] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.587801 (+   692us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.587819 (+    18us) client_negotiation.cc:656] calling sasl_client_start()
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.589435 (+  1616us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.591576 (+  2141us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.591583 (+     7us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.591599 (+    16us) client_negotiation.cc:760] calling sasl_client_step()
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.591935 (+   336us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592298 (+   363us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592301 (+     3us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592303 (+     2us) client_negotiation.cc:760] calling sasl_client_step()
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592466 (+   163us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592993 (+   527us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.592999 (+     6us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.593325 (+   326us) client_negotiation.cc:769] Sending connection context
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.593589 (+   264us) client_negotiation.cc:240] Negotiation successful
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 03:07:06.593784 (+   195us) negotiation.cc:327] Negotiation complete: OK
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":374,"thread_start_us":155,"threads_started":1}
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.596020 27735 heartbeater.cc:347] Connected to a master server at 127.26.110.254:42815
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.596252 27735 heartbeater.cc:464] Registering TS with master...
03:07:06.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.596720 27735 heartbeater.cc:511] Master 127.26.110.254:42815 requested a full tablet report, sending...
03:07:06.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.597759 27138 ts_manager.cc:194] Registered new tserver with Master: e5c7728b9611409ba52301d67281fc7c (127.26.110.195:35567)
03:07:06.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.598361 27138 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.26.110.195@KRBTEST.COM'} at 127.26.110.195:32905
03:07:06.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.605477 27067 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
03:07:06.606 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
03:07:06.607 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

03:07:06.617 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

03:07:06.618 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

03:07:06.629 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.26.110.254"
      port: 42815
    }
    bound_http_address {
      host: "127.26.110.254"
      port: 36501
    }
  }
}

03:07:06.634 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

03:07:06.636 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.26.110.193"
      port: 35161
    }
    bound_http_address {
      host: "127.26.110.193"
      port: 45179
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.26.110.194"
      port: 34209
    }
    bound_http_address {
      host: "127.26.110.194"
      port: 32913
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.26.110.195"
      port: 35567
    }
    bound_http_address {
      host: "127.26.110.195"
      port: 39029
    }
  }
}

03:07:06.637 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
03:07:06.861 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskZjwQ17/test-tmp/mini-kudu-cluster5361604177138226941/krb5kdc/krb5cc
03:07:06.873 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
03:07:06.892 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
03:07:06.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.896163 27067 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu with pid 27219
03:07:06.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.907960 27120 connection.cc:535] server connection from 127.26.110.193:35847 recv error: Network error: failed to read from TLS socket (remote: 127.26.110.193:35847): Connection reset by peer (error 104)
03:07:06.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.908159 27067 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu with pid 27392
03:07:06.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.921582 27122 connection.cc:535] server connection from 127.26.110.194:53547 recv error: Network error: failed to read from TLS socket (remote: 127.26.110.194:53547): Connection reset by peer (error 104)
03:07:06.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.921808 27067 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu with pid 27565
03:07:06.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.934859 27121 connection.cc:535] server connection from 127.26.110.195:32905 recv error: Network error: failed to read from TLS socket (remote: 127.26.110.195:32905): Connection reset by peer (error 104)
03:07:06.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 03:07:06.935225 27067 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskZjwQ17/build/debug/bin/kudu with pid 27099
03:07:06.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 03:07:06.946179 27075 connection.cc:535] client connection to 127.26.110.254:42815 recv error: Network error: failed to read from TLS socket (remote: 127.26.110.254:42815): Connection reset by peer (error 104)
03:07:06.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T03:07:06Z chronyd exiting

Time: 3.902

OK (1 test)

