JUnit version 4.13.2
.22:12:42.504 [DEBUG - main] (TestNegotiationTLSv13.java:108) enabled TLS protocols: TLSv1.3 TLSv1.2 TLSv1.1 TLSv1
22:12:42.507 [DEBUG - main] (TestNegotiationTLSv13.java:110) supported TLS protocols: TLSv1.3 TLSv1.2 SSLv3 TLSv1.1 SSLv2Hello TLSv1
22:12:42.516 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskKk0AbK/test-tmp
22:12:42.519 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
22:12:42.522 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskKk0AbK/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
22:12:42.801 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 0
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581"
  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 {
  }
}

22:12:42.817 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
22:12:42.819 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

22:12:42.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:42.821676 20649 mini_oidc.cc:152] Starting JWKS server
22:12:42.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:42.825802 20649 webserver.cc:460] Webserver started at http://127.0.0.1:37651/ using document root <none> and password file <none>
22:12:42.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:42.826093 20649 mini_oidc.cc:189] Starting OIDC Discovery server
22:12:42.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:42.826511 20649 webserver.cc:460] Webserver started at http://127.0.0.1:45935/ using document root <none> and password file <none>
22:12:42.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T22:12:42Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
22:12:42.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T22:12:42Z Disabled control of system clock
22:12:42.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:42.857107 20649 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu
22:12:42.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu
22:12:42.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/wal
22:12:42.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/data
22:12:42.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
22:12:42.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
22:12:42.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
22:12:42.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:12:42.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:12:42.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:12:42.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/logs
22:12:42.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/data/info.pb
22:12:42.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:12:42.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
22:12:42.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
22:12:42.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
22:12:42.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
22:12:42.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:12:42.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:12:42.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.42.126:41591
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.42.126
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.42.84:35855
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.42.126:41591
22:12:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
22:12:42.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37651/jwks.json
22:12:42.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
22:12:42.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3 with env {}
22:12:43.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.028890 20664 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
22:12:43.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.029335 20664 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
22:12:43.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.029384 20664 flags.cc:425] Enabled unsafe flag: --never_fsync=true
22:12:43.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.034237 20664 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
22:12:43.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.034343 20664 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
22:12:43.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.034364 20664 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
22:12:43.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.034382 20664 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
22:12:43.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.034402 20664 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
22:12:43.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.034417 20664 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:37651/jwks.json
22:12:43.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.042712 20664 master_runner.cc:386] Master server non-default flags:
22:12:43.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:12:43.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.42.84:35855
22:12:43.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:12:43.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
22:12:43.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/data
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/wal
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.42.126:41591
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.42.126:41591
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37651/jwks.json
22:12:43.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3
22:12:43.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:12:43.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:12:43.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/data/info.pb
22:12:43.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.42.126
22:12:43.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:12:43.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
22:12:43.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.20664
22:12:43.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:12:43.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
22:12:43.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
22:12:43.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:12:43.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/logs
22:12:43.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:12:43.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
22:12:43.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
22:12:43.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
22:12:43.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
22:12:43.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
22:12:43.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
22:12:43.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 21:38:32 UTC on ccycloud.quasar-aqvrvy.root.comops.site
22:12:43.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581604
22:12:43.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.045030 20664 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
22:12:43.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.047550 20664 file_cache.cc:493] Constructed file cache file cache with capacity 419430
22:12:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.062711 20674 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
22:12:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.062786 20675 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
22:12:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.062813 20664 server_base.cc:1034] running on GCE node
22:12:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.064551 20679 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
22:12:43.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.065760 20664 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
22:12:43.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:43.065958 20664 system_unsync_time.cc:38] NTP support is disabled. Clock error bounds will not be accurate. This configuration is not suitable for distributed clusters.
22:12:43.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.066030 20664 hybrid_clock.cc:648] HybridClock initialized: now 1786486363066021 us; error 0 us; skew 500 ppm
22:12:43.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.078421 20664 webserver.cc:460] Webserver started at http://127.20.42.126:37983/ using document root <none> and password file <none>
22:12:43.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.079499 20664 fs_manager.cc:359] Metadata directory not provided
22:12:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.079619 20664 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
22:12:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.079989 20664 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
22:12:43.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.083040 20664 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/data/instance:
22:12:43.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eaed9cd827c448da9d42f8ceef5980e8"
22:12:43.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:43 on dist-test-slave-7z32"
22:12:43.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.084352 20664 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/wal/instance:
22:12:43.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eaed9cd827c448da9d42f8ceef5980e8"
22:12:43.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:43 on dist-test-slave-7z32"
22:12:43.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.090322 20664 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.006s	sys 0.000s
22:12:43.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.094573 20687 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
22:12:43.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.096868 20664 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.000s
22:12:43.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.097226 20664 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/data,/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/wal
22:12:43.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eaed9cd827c448da9d42f8ceef5980e8"
22:12:43.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:43 on dist-test-slave-7z32"
22:12:43.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.097419 20664 fs_report.cc:383] FS layout report
22:12:43.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
22:12:43.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/wal
22:12:43.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/wal
22:12:43.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster7151570979717078581/master-0/data/data
22:12:43.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
22:12:43.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
22:12:43.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
22:12:43.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
22:12:43.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
22:12:43.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
22:12:43.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
22:12:43.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
22:12:43.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
22:12:43.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
22:12:43.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
22:12:43.124 [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
22:12:43.148 [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-taskKk0AbK/build/debug/bin/kudu: process exited with non-zero status 1"
}

22:12:43.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T22:12:43Z chronyd exiting
22:12:43.196 [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-taskKk0AbK/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]
22:12:43.206 [INFO - main] (RandomUtils.java:49) Using random seed: 1786486363206
22:12:43.216 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
22:12:43.284 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
22:12:43.285 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskKk0AbK/test-tmp
22:12:43.286 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
22:12:43.286 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskKk0AbK/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
22:12:43.289 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114"
  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 {
  }
}

22:12:43.447 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
22:12:43.447 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

22:12:43.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.450065 20689 mini_oidc.cc:152] Starting JWKS server
22:12:43.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.453513 20689 webserver.cc:460] Webserver started at http://127.0.0.1:40793/ using document root <none> and password file <none>
22:12:43.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.453749 20689 mini_oidc.cc:189] Starting OIDC Discovery server
22:12:43.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:43.454124 20689 webserver.cc:460] Webserver started at http://127.0.0.1:39333/ using document root <none> and password file <none>
22:12:43.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
22:12:43.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/principal' for realm 'KRBTEST.COM',
22:12:43.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
22:12:43.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:43 dist-test-slave-7z32 krb5kdc[20712](info): setting up network...
22:12:43.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
22:12:43.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:43 dist-test-slave-7z32 krb5kdc[20712](info): set up 2 sockets
22:12:43.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:43 dist-test-slave-7z32 krb5kdc[20712](info): commencing operation
22:12:43.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
22:12:44.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:44.859545 20689 mini_kdc.cc:121] Time spent starting KDC: real 1.394s	user 0.003s	sys 0.008s
22:12:44.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
22:12:44.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
22:12:44.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
22:12:44.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
22:12:44.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
22:12:44.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
22:12:44.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
22:12:44.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
22:12:44.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
22:12:44.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
22:12:44.960 [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-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/test-user.keytab.
22:12:44.960 [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-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/test-user.keytab.
22:12:44.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:44 dist-test-slave-7z32 krb5kdc[20712](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786486364, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
22:12:44.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
22:12:44.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T22:12:44Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
22:12:44.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T22:12:44Z Disabled control of system clock
22:12:45.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.20.52.126@KRBTEST.COM; defaulting to no policy
22:12:45.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
22:12:45.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.20.52.126@KRBTEST.COM" created.
22:12:45.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
22:12:45.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.20.52.126 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.126.keytab.
22:12:45.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.20.52.126 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.126.keytab.
22:12:45.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.037009 20689 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu
22:12:45.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu
22:12:45.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/wal
22:12:45.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/data
22:12:45.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
22:12:45.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
22:12:45.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
22:12:45.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:12:45.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:12:45.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:12:45.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/logs
22:12:45.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/data/info.pb
22:12:45.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:12:45.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
22:12:45.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
22:12:45.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
22:12:45.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
22:12:45.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:12:45.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:12:45.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:12:45.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
22:12:45.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
22:12:45.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
22:12:45.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
22:12:45.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.52.126:46385
22:12:45.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.52.126
22:12:45.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:12:45.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.126.keytab
22:12:45.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.20.52.126
22:12:45.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
22:12:45.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
22:12:45.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
22:12:45.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.52.84:41513
22:12:45.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:12:45.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:12:45.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:12:45.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
22:12:45.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.52.126:46385
22:12:45.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
22:12:45.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40793/jwks.json
22:12:45.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
22:12:45.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
22:12:45.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
22:12:45.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.190970 20728 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
22:12:45.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.191460 20728 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
22:12:45.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.191542 20728 flags.cc:425] Enabled unsafe flag: --never_fsync=true
22:12:45.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.196499 20728 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
22:12:45.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.196661 20728 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
22:12:45.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.196698 20728 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
22:12:45.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.196725 20728 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
22:12:45.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.196758 20728 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
22:12:45.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.196789 20728 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
22:12:45.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.196806 20728 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:40793/jwks.json
22:12:45.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.203718 20728 master_runner.cc:386] Master server non-default flags:
22:12:45.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:12:45.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.52.84:41513
22:12:45.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:12:45.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:12:45.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/data
22:12:45.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/wal
22:12:45.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
22:12:45.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.52.126:46385
22:12:45.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
22:12:45.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
22:12:45.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.126.keytab
22:12:45.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.20.52.126
22:12:45.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:12:45.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:12:45.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
22:12:45.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.52.126:46385
22:12:45.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
22:12:45.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
22:12:45.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
22:12:45.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40793/jwks.json
22:12:45.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
22:12:45.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
22:12:45.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
22:12:45.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/data/info.pb
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.52.126
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.20728
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:12:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/logs
22:12:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:12:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
22:12:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
22:12:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
22:12:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
22:12:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
22:12:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
22:12:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 21:38:32 UTC on ccycloud.quasar-aqvrvy.root.comops.site
22:12:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581604
22:12:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.205813 20728 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
22:12:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.207844 20728 file_cache.cc:493] Constructed file cache file cache with capacity 419430
22:12:45.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.221665 20734 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
22:12:45.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.221928 20728 server_base.cc:1034] running on GCE node
22:12:45.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.222236 20735 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
22:12:45.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.221709 20740 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
22:12:45.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.223381 20728 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
22:12:45.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.225436 20728 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
22:12:45.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.228926 20728 hybrid_clock.cc:648] HybridClock initialized: now 1786486365228889 us; error 127 us; skew 500 ppm
22:12:45.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:45 dist-test-slave-7z32 krb5kdc[20712](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786486365, etypes {rep=17 tkt=17 ses=17}, kudu/127.20.52.126@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
22:12:45.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.233896 20728 init.cc:377] Logged in from keytab as kudu/127.20.52.126@KRBTEST.COM (short username kudu)
22:12:45.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.235860 20728 webserver.cc:460] Webserver started at http://127.20.52.126:33769/ using document root <none> and password file <none>
22:12:45.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.236718 20728 fs_manager.cc:359] Metadata directory not provided
22:12:45.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.236816 20728 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
22:12:45.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.237085 20728 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
22:12:45.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.240234 20728 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/data/instance:
22:12:45.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ca5694589c05495b9a6e26b8ce1d47f6"
22:12:45.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:45 on dist-test-slave-7z32"
22:12:45.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.241006 20728 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/wal/instance:
22:12:45.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ca5694589c05495b9a6e26b8ce1d47f6"
22:12:45.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:45 on dist-test-slave-7z32"
22:12:45.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.246702 20728 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.006s	sys 0.000s
22:12:45.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.250793 20753 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
22:12:45.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.252645 20728 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.000s
22:12:45.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.252805 20728 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/data,/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/wal
22:12:45.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ca5694589c05495b9a6e26b8ce1d47f6"
22:12:45.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:45 on dist-test-slave-7z32"
22:12:45.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.252936 20728 fs_report.cc:383] FS layout report
22:12:45.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
22:12:45.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/wal
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/wal
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/data/data
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
22:12:45.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
22:12:45.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
22:12:45.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.275321 20728 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
22:12:45.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.280387 20728 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
22:12:45.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.280613 20728 kserver.cc:163] Server-wide thread pool size limit: 3276
22:12:45.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.289654 20728 rpc_server.cc:307] RPC server started. Bound to: 127.20.52.126:46385
22:12:45.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.289990 20846 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.20.52.126:46385 every 8 connection(s)
22:12:45.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.291039 20728 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/data/info.pb
22:12:45.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.296334 20847 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
22:12:45.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.299276 20689 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu as pid 20728
22:12:45.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.299510 20689 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/master-0/wal/instance
22:12:45.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.305226 20847 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6: Bootstrap starting.
22:12:45.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.308764 20847 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6: Neither blocks nor log segments found. Creating new log.
22:12:45.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.310310 20847 log.cc:824] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6: Log is configured to *not* fsync() on all Append() calls
22:12:45.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.313874 20847 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6: No bootstrap required, opened a new log
22:12:45.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.319306 20847 raft_consensus.cc:348] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca5694589c05495b9a6e26b8ce1d47f6" member_type: VOTER last_known_addr { host: "127.20.52.126" port: 46385 } }
22:12:45.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.319741 20847 raft_consensus.cc:374] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
22:12:45.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.319808 20847 raft_consensus.cc:729] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ca5694589c05495b9a6e26b8ce1d47f6, State: Initialized, Role: FOLLOWER
22:12:45.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.320518 20847 consensus_queue.cc:260] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [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: "ca5694589c05495b9a6e26b8ce1d47f6" member_type: VOTER last_known_addr { host: "127.20.52.126" port: 46385 } }
22:12:45.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.320735 20847 raft_consensus.cc:388] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
22:12:45.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:45 dist-test-slave-7z32 krb5kdc[20712](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786486364, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.20.52.126@KRBTEST.COM
22:12:45.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.320811 20847 raft_consensus.cc:482] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
22:12:45.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.320927 20847 raft_consensus.cc:3037] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [term 0 FOLLOWER]: Advancing to term 1
22:12:45.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.322618 20847 raft_consensus.cc:504] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca5694589c05495b9a6e26b8ce1d47f6" member_type: VOTER last_known_addr { host: "127.20.52.126" port: 46385 } }
22:12:45.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.323490 20847 leader_election.cc:302] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [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: ca5694589c05495b9a6e26b8ce1d47f6; no voters: 
22:12:45.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.324123 20847 leader_election.cc:288] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [CANDIDATE]: Term 1 election: Requested vote from peers 
22:12:45.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.325296 20854 raft_consensus.cc:2781] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [term 1 FOLLOWER]: Leader election won for term 1
22:12:45.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.325783 20854 raft_consensus.cc:686] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [term 1 LEADER]: Becoming Leader. State: Replica: ca5694589c05495b9a6e26b8ce1d47f6, State: Running, Role: LEADER
22:12:45.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.326457 20847 sys_catalog.cc:564] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [sys.catalog]: configured and running, proceeding with master startup.
22:12:45.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.326923 20854 consensus_queue.cc:237] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [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: "ca5694589c05495b9a6e26b8ce1d47f6" member_type: VOTER last_known_addr { host: "127.20.52.126" port: 46385 } }
22:12:45.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.329280 20854 sys_catalog.cc:455] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "ca5694589c05495b9a6e26b8ce1d47f6" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca5694589c05495b9a6e26b8ce1d47f6" member_type: VOTER last_known_addr { host: "127.20.52.126" port: 46385 } } }
22:12:45.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.330020 20854 sys_catalog.cc:458] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [sys.catalog]: This master's current role is: LEADER
22:12:45.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.330889 20850 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
22:12:45.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.304682 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.0.0.1:59744 (local address 127.20.52.126:46385)
22:12:45.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.305258 (+   576us) server_negotiation.cc:206] Beginning negotiation
22:12:45.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.305275 (+    17us) server_negotiation.cc:399] Waiting for connection header
22:12:45.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.306571 (+  1296us) server_negotiation.cc:407] Connection header received
22:12:45.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.308821 (+  2250us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
22:12:45.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.308839 (+    18us) server_negotiation.cc:461] Received NEGOTIATE request from client
22:12:45.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.309231 (+   392us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
22:12:45.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.309639 (+   408us) server_negotiation.cc:226] Negotiated authn=SASL
22:12:45.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.312821 (+  3182us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
22:12:45.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.314170 (+  1349us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
22:12:45.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.315766 (+  1596us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
22:12:45.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.316322 (+   556us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
22:12:45.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.316563 (+   241us) 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
22:12:45.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.321943 (+  5380us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
22:12:45.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.321953 (+    10us) server_negotiation.cc:881] Received SASL_INITIATE request from client
22:12:45.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.321974 (+    21us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
22:12:45.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.322025 (+    51us) server_negotiation.cc:922] calling sasl_server_start()
22:12:45.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.325019 (+  2994us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
22:12:45.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.325999 (+   980us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
22:12:45.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.326007 (+     8us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
22:12:45.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.326014 (+     7us) server_negotiation.cc:967] calling sasl_server_step()
22:12:45.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.326186 (+   172us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
22:12:45.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.326732 (+   546us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
22:12:45.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.326735 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
22:12:45.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.326738 (+     3us) server_negotiation.cc:967] calling sasl_server_step()
22:12:45.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.327485 (+   747us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
22:12:45.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.327738 (+   253us) server_negotiation.cc:1035] Waiting for connection context
22:12:45.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.328773 (+  1035us) server_negotiation.cc:299] Negotiation successful
22:12:45.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.329120 (+   347us) negotiation.cc:327] Negotiation complete: OK
22:12:45.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":398,"thread_start_us":206,"threads_started":1}
22:12:45.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.331116 20854 sys_catalog.cc:455] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [sys.catalog]: SysCatalogTable state changed. Reason: New leader ca5694589c05495b9a6e26b8ce1d47f6. Latest consensus state: current_term: 1 leader_uuid: "ca5694589c05495b9a6e26b8ce1d47f6" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca5694589c05495b9a6e26b8ce1d47f6" member_type: VOTER last_known_addr { host: "127.20.52.126" port: 46385 } } }
22:12:45.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.333854 20854 sys_catalog.cc:458] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6 [sys.catalog]: This master's current role is: LEADER
22:12:45.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.335130 20873 catalog_manager.cc:1558] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
22:12:45.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.335318 20873 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
22:12:45.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.337908 20874 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
22:12:45.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.340101 20874 catalog_manager.cc:1484] Initializing Kudu cluster ID...
22:12:45.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.351469 20874 catalog_manager.cc:1347] Generated new cluster ID: 68d243375cf6444f8e24c9514c8efb33
22:12:45.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.351579 20874 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
22:12:45.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.377043 20874 catalog_manager.cc:1370] Generated new certificate authority record
22:12:45.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.378895 20874 catalog_manager.cc:1504] Loading token signing keys...
22:12:45.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.389158 20874 catalog_manager.cc:5868] T 00000000000000000000000000000000 P ca5694589c05495b9a6e26b8ce1d47f6: Generated new TSK 0
22:12:45.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.390555 20874 catalog_manager.cc:1514] Initializing in-progress tserver states...
22:12:45.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.20.52.65@KRBTEST.COM; defaulting to no policy
22:12:45.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
22:12:45.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.20.52.65@KRBTEST.COM" created.
22:12:45.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
22:12:45.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.20.52.65 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.65.keytab.
22:12:45.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.20.52.65 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.65.keytab.
22:12:45.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.435699 20689 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/wal
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/data
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/logs
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/data/info.pb
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:12:45.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.52.65:0
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.52.65
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.52.65
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.52.126:46385
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.65.keytab
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.20.52.65
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.52.84:41513
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
22:12:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
22:12:45.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
22:12:45.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.620627 20883 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
22:12:45.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.621140 20883 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
22:12:45.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.621219 20883 flags.cc:425] Enabled unsafe flag: --never_fsync=true
22:12:45.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.627381 20883 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
22:12:45.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.627553 20883 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
22:12:45.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.627727 20883 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.20.52.65
22:12:45.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.639850 20883 tablet_server_runner.cc:78] Tablet server non-default flags:
22:12:45.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:12:45.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.52.84:41513
22:12:45.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:12:45.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:12:45.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/data
22:12:45.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/wal
22:12:45.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
22:12:45.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
22:12:45.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.65.keytab
22:12:45.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.20.52.65
22:12:45.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:12:45.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:12:45.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.52.65:0
22:12:45.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
22:12:45.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
22:12:45.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
22:12:45.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/data/info.pb
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.52.65
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.52.126:46385
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.20883
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
22:12:45.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.52.65
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/logs
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 21:38:32 UTC on ccycloud.quasar-aqvrvy.root.comops.site
22:12:45.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581604
22:12:45.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.642076 20883 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
22:12:45.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.645993 20883 file_cache.cc:493] Constructed file cache file cache with capacity 419430
22:12:45.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.665211 20891 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
22:12:45.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.665220 20896 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
22:12:45.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.665220 20892 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
22:12:45.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.667075 20883 server_base.cc:1034] running on GCE node
22:12:45.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.667923 20883 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
22:12:45.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.668965 20883 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
22:12:45.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.670380 20883 hybrid_clock.cc:648] HybridClock initialized: now 1786486365670324 us; error 69 us; skew 500 ppm
22:12:45.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:45 dist-test-slave-7z32 krb5kdc[20712](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786486365, etypes {rep=17 tkt=17 ses=17}, kudu/127.20.52.65@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
22:12:45.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.675237 20883 init.cc:377] Logged in from keytab as kudu/127.20.52.65@KRBTEST.COM (short username kudu)
22:12:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.676754 20883 webserver.cc:460] Webserver started at http://127.20.52.65:40941/ using document root <none> and password file <none>
22:12:45.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.677582 20883 fs_manager.cc:359] Metadata directory not provided
22:12:45.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.677670 20883 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
22:12:45.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.677922 20883 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
22:12:45.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.681159 20883 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/data/instance:
22:12:45.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3f74a6f28576436480b7e1d561a068a6"
22:12:45.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:45 on dist-test-slave-7z32"
22:12:45.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.682394 20883 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/wal/instance:
22:12:45.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3f74a6f28576436480b7e1d561a068a6"
22:12:45.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:45 on dist-test-slave-7z32"
22:12:45.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.688561 20883 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.004s	sys 0.000s
22:12:45.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.692754 20909 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
22:12:45.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.694644 20883 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.005s	sys 0.000s
22:12:45.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.694809 20883 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/data,/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/wal
22:12:45.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3f74a6f28576436480b7e1d561a068a6"
22:12:45.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:45 on dist-test-slave-7z32"
22:12:45.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.695036 20883 fs_report.cc:383] FS layout report
22:12:45.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
22:12:45.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/wal
22:12:45.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/wal
22:12:45.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/data/data
22:12:45.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
22:12:45.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
22:12:45.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
22:12:45.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
22:12:45.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
22:12:45.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
22:12:45.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
22:12:45.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
22:12:45.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
22:12:45.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
22:12:45.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
22:12:45.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.714218 20883 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
22:12:45.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.718737 20883 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
22:12:45.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.719249 20883 kserver.cc:163] Server-wide thread pool size limit: 3276
22:12:45.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.720315 20883 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
22:12:45.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.721447 20883 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
22:12:45.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.721508 20883 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
22:12:45.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.721555 20883 ts_tablet_manager.cc:610] Registered 0 tablets
22:12:45.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.721571 20883 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
22:12:45.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.734418 20883 rpc_server.cc:307] RPC server started. Bound to: 127.20.52.65:42725
22:12:45.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.734462 21090 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.20.52.65:42725 every 8 connection(s)
22:12:45.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.735800 20883 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/data/info.pb
22:12:45.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.741482 20689 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu as pid 20883
22:12:45.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.741657 20689 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-0/wal/instance
22:12:45.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:45 dist-test-slave-7z32 krb5kdc[20712](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786486365, etypes {rep=17 tkt=17 ses=17}, kudu/127.20.52.65@KRBTEST.COM for kudu/127.20.52.126@KRBTEST.COM
22:12:45.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.20.52.66@KRBTEST.COM; defaulting to no policy
22:12:45.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.756515 20850 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
22:12:45.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.739089 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.20.52.65:43729 (local address 127.20.52.126:46385)
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.739302 (+   213us) server_negotiation.cc:206] Beginning negotiation
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.739307 (+     5us) server_negotiation.cc:399] Waiting for connection header
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.740630 (+  1323us) server_negotiation.cc:407] Connection header received
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.742521 (+  1891us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.742525 (+     4us) server_negotiation.cc:461] Received NEGOTIATE request from client
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.742591 (+    66us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.742727 (+   136us) server_negotiation.cc:226] Negotiated authn=SASL
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.744257 (+  1530us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.744882 (+   625us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.746612 (+  1730us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.746994 (+   382us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.747150 (+   156us) 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
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.751500 (+  4350us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.751504 (+     4us) server_negotiation.cc:881] Received SASL_INITIATE request from client
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.751507 (+     3us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.751541 (+    34us) server_negotiation.cc:922] calling sasl_server_start()
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.753282 (+  1741us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754059 (+   777us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754062 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754063 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754151 (+    88us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
22:12:45.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754640 (+   489us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754643 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754645 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754995 (+   350us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.755120 (+   125us) server_negotiation.cc:1035] Waiting for connection context
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.756218 (+  1098us) server_negotiation.cc:299] Negotiation successful
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.756356 (+   138us) negotiation.cc:327] Negotiation complete: OK
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":81}
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.20.52.66@KRBTEST.COM" created.
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.757798 21094 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.739657 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.20.52.126:46385 (local address 127.20.52.65:43729)
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.740405 (+   748us) negotiation.cc:107] Waiting for socket to connect
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.740475 (+    70us) client_negotiation.cc:174] Beginning negotiation
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.742222 (+  1747us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
22:12:45.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.743002 (+   780us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
22:12:45.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.743011 (+     9us) client_negotiation.cc:394] Received NEGOTIATE response from server
22:12:45.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.743488 (+   477us) client_negotiation.cc:189] Negotiated authn=SASL
22:12:45.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.744060 (+   572us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
22:12:45.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.744076 (+    16us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
22:12:45.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.745037 (+   961us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
22:12:45.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.745046 (+     9us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
22:12:45.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.746420 (+  1374us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
22:12:45.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.746437 (+    17us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
22:12:45.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.747236 (+   799us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
22:12:45.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.747242 (+     6us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
22:12:45.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.747543 (+   301us) 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
22:12:45.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.748603 (+  1060us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
22:12:45.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.748628 (+    25us) client_negotiation.cc:656] calling sasl_client_start()
22:12:45.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.751147 (+  2519us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
22:12:45.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.753498 (+  2351us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
22:12:45.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.753507 (+     9us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
22:12:45.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.753542 (+    35us) client_negotiation.cc:760] calling sasl_client_step()
22:12:45.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.753884 (+   342us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754285 (+   401us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754288 (+     3us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754290 (+     2us) client_negotiation.cc:760] calling sasl_client_step()
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.754482 (+   192us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.755211 (+   729us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.755220 (+     9us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.755704 (+   484us) client_negotiation.cc:769] Sending connection context
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.756004 (+   300us) client_negotiation.cc:240] Negotiation successful
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:45.756338 (+   334us) negotiation.cc:327] Negotiation complete: OK
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":433,"thread_start_us":167,"threads_started":1}
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.759874 21091 heartbeater.cc:347] Connected to a master server at 127.20.52.126:46385
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.760375 21091 heartbeater.cc:464] Registering TS with master...
22:12:45.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.761196 21091 heartbeater.cc:511] Master 127.20.52.126:46385 requested a full tablet report, sending...
22:12:45.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.764232 20781 ts_manager.cc:194] Registered new tserver with Master: 3f74a6f28576436480b7e1d561a068a6 (127.20.52.65:42725)
22:12:45.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.766251 20781 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.20.52.65@KRBTEST.COM'} at 127.20.52.65:43729
22:12:45.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
22:12:45.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.20.52.66 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.66.keytab.
22:12:45.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.20.52.66 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.66.keytab.
22:12:45.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.787640 20689 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/wal
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/data
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/logs
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/data/info.pb
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.52.66:0
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.52.66
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.52.66
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:12:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.52.126:46385
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.66.keytab
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.20.52.66
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.52.84:41513
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
22:12:45.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
22:12:45.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.939128 21099 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
22:12:45.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.939518 21099 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
22:12:45.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.939594 21099 flags.cc:425] Enabled unsafe flag: --never_fsync=true
22:12:45.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.944769 21099 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
22:12:45.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.944931 21099 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
22:12:45.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.945040 21099 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.20.52.66
22:12:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.951400 21099 tablet_server_runner.cc:78] Tablet server non-default flags:
22:12:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:12:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.52.84:41513
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/data
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/wal
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.66.keytab
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.20.52.66
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.52.66:0
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/data/info.pb
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.52.66
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.52.126:46385
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
22:12:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21099
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.52.66
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/logs
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 21:38:32 UTC on ccycloud.quasar-aqvrvy.root.comops.site
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581604
22:12:45.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.953081 21099 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
22:12:45.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.954523 21099 file_cache.cc:493] Constructed file cache file cache with capacity 419430
22:12:45.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.967182 21111 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
22:12:45.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.967214 21106 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
22:12:45.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:45.967182 21107 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
22:12:45.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.968376 21099 server_base.cc:1034] running on GCE node
22:12:45.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.969005 21099 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
22:12:45.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.969890 21099 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
22:12:45.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.973331 21099 hybrid_clock.cc:648] HybridClock initialized: now 1786486365973274 us; error 58 us; skew 500 ppm
22:12:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:45 dist-test-slave-7z32 krb5kdc[20712](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786486365, etypes {rep=17 tkt=17 ses=17}, kudu/127.20.52.66@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
22:12:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.977276 21099 init.cc:377] Logged in from keytab as kudu/127.20.52.66@KRBTEST.COM (short username kudu)
22:12:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.978575 21099 webserver.cc:460] Webserver started at http://127.20.52.66:45525/ using document root <none> and password file <none>
22:12:45.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.979363 21099 fs_manager.cc:359] Metadata directory not provided
22:12:45.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.979445 21099 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
22:12:45.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.979686 21099 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
22:12:45.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.982241 21099 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/data/instance:
22:12:45.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "66340e29adc7400ead12c6179350367c"
22:12:45.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:45 on dist-test-slave-7z32"
22:12:45.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.982985 21099 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/wal/instance:
22:12:45.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "66340e29adc7400ead12c6179350367c"
22:12:45.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:45 on dist-test-slave-7z32"
22:12:45.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.989151 21099 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.004s	sys 0.000s
22:12:45.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.992578 21123 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
22:12:45.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.994525 21099 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.004s	sys 0.000s
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.994694 21099 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/data,/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/wal
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "66340e29adc7400ead12c6179350367c"
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:45 on dist-test-slave-7z32"
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:45.994804 21099 fs_report.cc:383] FS layout report
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/wal
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/wal
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/data/data
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
22:12:45.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
22:12:46.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.011706 21099 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
22:12:46.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.016614 21099 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
22:12:46.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.016837 21099 kserver.cc:163] Server-wide thread pool size limit: 3276
22:12:46.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.017556 21099 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
22:12:46.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.018778 21099 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
22:12:46.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.019045 21099 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.001s	sys 0.000s
22:12:46.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.019160 21099 ts_tablet_manager.cc:610] Registered 0 tablets
22:12:46.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.019187 21099 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
22:12:46.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.031426 21099 rpc_server.cc:307] RPC server started. Bound to: 127.20.52.66:33117
22:12:46.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.031467 21299 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.20.52.66:33117 every 8 connection(s)
22:12:46.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.032826 21099 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/data/info.pb
22:12:46.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.038810 20689 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu as pid 21099
22:12:46.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.039081 20689 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-1/wal/instance
22:12:46.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:46 dist-test-slave-7z32 krb5kdc[20712](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786486365, etypes {rep=17 tkt=17 ses=17}, kudu/127.20.52.66@KRBTEST.COM for kudu/127.20.52.126@KRBTEST.COM
22:12:46.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.20.52.67@KRBTEST.COM; defaulting to no policy
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.20.52.67@KRBTEST.COM" created.
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.055984 20850 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.036321 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.20.52.66:43093 (local address 127.20.52.126:46385)
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.036549 (+   228us) server_negotiation.cc:206] Beginning negotiation
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.036555 (+     6us) server_negotiation.cc:399] Waiting for connection header
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.037987 (+  1432us) server_negotiation.cc:407] Connection header received
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.040312 (+  2325us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.040316 (+     4us) server_negotiation.cc:461] Received NEGOTIATE request from client
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.040386 (+    70us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.040545 (+   159us) server_negotiation.cc:226] Negotiated authn=SASL
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.042503 (+  1958us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.043478 (+   975us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.045783 (+  2305us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.046222 (+   439us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.046381 (+   159us) 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
22:12:46.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.050564 (+  4183us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.050573 (+     9us) server_negotiation.cc:881] Received SASL_INITIATE request from client
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.050579 (+     6us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.050631 (+    52us) server_negotiation.cc:922] calling sasl_server_start()
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.052783 (+  2152us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.053662 (+   879us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.053666 (+     4us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.053667 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.053773 (+   106us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.054290 (+   517us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.054292 (+     2us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.054294 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.054514 (+   220us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.054630 (+   116us) server_negotiation.cc:1035] Waiting for connection context
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.055586 (+   956us) server_negotiation.cc:299] Negotiation successful
22:12:46.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.055744 (+   158us) negotiation.cc:327] Negotiation complete: OK
22:12:46.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":85}
22:12:46.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.057338 21303 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
22:12:46.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.036872 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.20.52.126:46385 (local address 127.20.52.66:43093)
22:12:46.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.037686 (+   814us) negotiation.cc:107] Waiting for socket to connect
22:12:46.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.037777 (+    91us) client_negotiation.cc:174] Beginning negotiation
22:12:46.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.039888 (+  2111us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
22:12:46.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.040837 (+   949us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
22:12:46.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.040849 (+    12us) client_negotiation.cc:394] Received NEGOTIATE response from server
22:12:46.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.041561 (+   712us) client_negotiation.cc:189] Negotiated authn=SASL
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.042283 (+   722us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.042301 (+    18us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.043793 (+  1492us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.043801 (+     8us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.045533 (+  1732us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.045550 (+    17us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.046456 (+   906us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.046459 (+     3us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.046720 (+   261us) 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
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.047864 (+  1144us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.047887 (+    23us) client_negotiation.cc:656] calling sasl_client_start()
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.050163 (+  2276us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.053017 (+  2854us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.053025 (+     8us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
22:12:46.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.053048 (+    23us) client_negotiation.cc:760] calling sasl_client_step()
22:12:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.053434 (+   386us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
22:12:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.053933 (+   499us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
22:12:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.053936 (+     3us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
22:12:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.053937 (+     1us) client_negotiation.cc:760] calling sasl_client_step()
22:12:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.054127 (+   190us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
22:12:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.054702 (+   575us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
22:12:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.054710 (+     8us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
22:12:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.055253 (+   543us) client_negotiation.cc:769] Sending connection context
22:12:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.055493 (+   240us) client_negotiation.cc:240] Negotiation successful
22:12:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.055817 (+   324us) negotiation.cc:327] Negotiation complete: OK
22:12:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":452,"thread_start_us":169,"threads_started":1}
22:12:46.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.062029 21300 heartbeater.cc:347] Connected to a master server at 127.20.52.126:46385
22:12:46.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.062698 21300 heartbeater.cc:464] Registering TS with master...
22:12:46.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.063656 21300 heartbeater.cc:511] Master 127.20.52.126:46385 requested a full tablet report, sending...
22:12:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.065412 20781 ts_manager.cc:194] Registered new tserver with Master: 66340e29adc7400ead12c6179350367c (127.20.52.66:33117)
22:12:46.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.066215 20781 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.20.52.66@KRBTEST.COM'} at 127.20.52.66:43093
22:12:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
22:12:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.20.52.67 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.67.keytab.
22:12:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.20.52.67 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.67.keytab.
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.088148 20689 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/wal
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/data
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/logs
22:12:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/data/info.pb
22:12:46.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:12:46.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
22:12:46.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
22:12:46.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
22:12:46.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.52.67:0
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.52.67
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.52.67
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.52.126:46385
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.67.keytab
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.20.52.67
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.52.84:41513
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
22:12:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
22:12:46.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
22:12:46.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.264070 21307 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
22:12:46.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.264549 21307 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
22:12:46.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.264604 21307 flags.cc:425] Enabled unsafe flag: --never_fsync=true
22:12:46.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.269781 21307 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
22:12:46.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.269887 21307 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
22:12:46.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.269971 21307 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.20.52.67
22:12:46.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.276713 21307 tablet_server_runner.cc:78] Tablet server non-default flags:
22:12:46.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:12:46.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.52.84:41513
22:12:46.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:12:46.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:12:46.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/data
22:12:46.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/wal
22:12:46.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
22:12:46.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
22:12:46.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kudu_127.20.52.67.keytab
22:12:46.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.20.52.67
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.52.67:0
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/data/info.pb
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.52.67
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.52.126:46385
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21307
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.52.67
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/logs
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
22:12:46.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
22:12:46.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
22:12:46.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 21:38:32 UTC on ccycloud.quasar-aqvrvy.root.comops.site
22:12:46.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581604
22:12:46.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.278759 21307 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
22:12:46.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.280838 21307 file_cache.cc:493] Constructed file cache file cache with capacity 419430
22:12:46.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.296723 21315 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
22:12:46.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.296747 21316 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
22:12:46.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.296747 21319 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
22:12:46.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.297677 21307 server_base.cc:1034] running on GCE node
22:12:46.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.298328 21307 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
22:12:46.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.299373 21307 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
22:12:46.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.300951 21307 hybrid_clock.cc:648] HybridClock initialized: now 1786486366300811 us; error 163 us; skew 500 ppm
22:12:46.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:46 dist-test-slave-7z32 krb5kdc[20712](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786486366, etypes {rep=17 tkt=17 ses=17}, kudu/127.20.52.67@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
22:12:46.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.305603 21307 init.cc:377] Logged in from keytab as kudu/127.20.52.67@KRBTEST.COM (short username kudu)
22:12:46.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.307194 21307 webserver.cc:460] Webserver started at http://127.20.52.67:36437/ using document root <none> and password file <none>
22:12:46.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.308022 21307 fs_manager.cc:359] Metadata directory not provided
22:12:46.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.308117 21307 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
22:12:46.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.308368 21307 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
22:12:46.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.311990 21307 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/data/instance:
22:12:46.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "93cc5c0d70874d82a58d4f765c16f66d"
22:12:46.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:46 on dist-test-slave-7z32"
22:12:46.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.313517 21307 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/wal/instance:
22:12:46.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "93cc5c0d70874d82a58d4f765c16f66d"
22:12:46.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:46 on dist-test-slave-7z32"
22:12:46.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.321122 21307 fs_manager.cc:691] Time spent creating directory manager: real 0.007s	user 0.005s	sys 0.003s
22:12:46.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.325587 21328 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
22:12:46.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.328145 21307 fs_manager.cc:725] Time spent opening block manager: real 0.005s	user 0.002s	sys 0.000s
22:12:46.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.328367 21307 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/data,/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/wal
22:12:46.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "93cc5c0d70874d82a58d4f765c16f66d"
22:12:46.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 22:12:46 on dist-test-slave-7z32"
22:12:46.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.328516 21307 fs_report.cc:383] FS layout report
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/wal
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/wal
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/data/data
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
22:12:46.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
22:12:46.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.356617 21307 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
22:12:46.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.361706 21307 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
22:12:46.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.362023 21307 kserver.cc:163] Server-wide thread pool size limit: 3276
22:12:46.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.362941 21307 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
22:12:46.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.364248 21307 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
22:12:46.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.364341 21307 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
22:12:46.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.364413 21307 ts_tablet_manager.cc:610] Registered 0 tablets
22:12:46.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.364437 21307 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
22:12:46.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.378427 21307 rpc_server.cc:307] RPC server started. Bound to: 127.20.52.67:43111
22:12:46.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.378450 21498 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.20.52.67:43111 every 8 connection(s)
22:12:46.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.379890 21307 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/data/info.pb
22:12:46.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.381822 20689 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu as pid 21307
22:12:46.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.381976 20689 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/ts-2/wal/instance
22:12:46.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 22:12:46 dist-test-slave-7z32 krb5kdc[20712](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786486366, etypes {rep=17 tkt=17 ses=17}, kudu/127.20.52.67@KRBTEST.COM for kudu/127.20.52.126@KRBTEST.COM
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.401809 20850 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.383084 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.20.52.67:60091 (local address 127.20.52.126:46385)
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.383330 (+   246us) server_negotiation.cc:206] Beginning negotiation
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.383337 (+     7us) server_negotiation.cc:399] Waiting for connection header
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.384919 (+  1582us) server_negotiation.cc:407] Connection header received
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.387149 (+  2230us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.387153 (+     4us) server_negotiation.cc:461] Received NEGOTIATE request from client
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.387216 (+    63us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.387306 (+    90us) server_negotiation.cc:226] Negotiated authn=SASL
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.388781 (+  1475us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.389426 (+   645us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.391252 (+  1826us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.391734 (+   482us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.391869 (+   135us) 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
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.396068 (+  4199us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.396072 (+     4us) server_negotiation.cc:881] Received SASL_INITIATE request from client
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.396075 (+     3us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.396114 (+    39us) server_negotiation.cc:922] calling sasl_server_start()
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.398242 (+  2128us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.399467 (+  1225us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.399470 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.399472 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
22:12:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.399574 (+   102us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.400212 (+   638us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.400217 (+     5us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.400220 (+     3us) server_negotiation.cc:967] calling sasl_server_step()
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.400517 (+   297us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.400668 (+   151us) server_negotiation.cc:1035] Waiting for connection context
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.401500 (+   832us) server_negotiation.cc:299] Negotiation successful
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.401622 (+   122us) negotiation.cc:327] Negotiation complete: OK
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":89}
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.402966 21503 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.383855 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.20.52.126:46385 (local address 127.20.52.67:60091)
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.384704 (+   849us) negotiation.cc:107] Waiting for socket to connect
22:12:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.384771 (+    67us) client_negotiation.cc:174] Beginning negotiation
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.386813 (+  2042us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.387516 (+   703us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.387525 (+     9us) client_negotiation.cc:394] Received NEGOTIATE response from server
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.387995 (+   470us) client_negotiation.cc:189] Negotiated authn=SASL
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.388614 (+   619us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.388629 (+    15us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.389642 (+  1013us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.389647 (+     5us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.391017 (+  1370us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.391040 (+    23us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.392041 (+  1001us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.392045 (+     4us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.392318 (+   273us) 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
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.393245 (+   927us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.393273 (+    28us) client_negotiation.cc:656] calling sasl_client_start()
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.395612 (+  2339us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.398514 (+  2902us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.398524 (+    10us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.398576 (+    52us) client_negotiation.cc:760] calling sasl_client_step()
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.399220 (+   644us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.399772 (+   552us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.399777 (+     5us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.399779 (+     2us) client_negotiation.cc:760] calling sasl_client_step()
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.400038 (+   259us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.400687 (+   649us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.400700 (+    13us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.401147 (+   447us) client_negotiation.cc:769] Sending connection context
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.401415 (+   268us) client_negotiation.cc:240] Negotiation successful
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 22:12:46.401721 (+   306us) negotiation.cc:327] Negotiation complete: OK
22:12:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":521,"thread_start_us":241,"threads_started":1}
22:12:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.404959 21499 heartbeater.cc:347] Connected to a master server at 127.20.52.126:46385
22:12:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.405269 21499 heartbeater.cc:464] Registering TS with master...
22:12:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.405889 21499 heartbeater.cc:511] Master 127.20.52.126:46385 requested a full tablet report, sending...
22:12:46.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.407719 20781 ts_manager.cc:194] Registered new tserver with Master: 93cc5c0d70874d82a58d4f765c16f66d (127.20.52.67:43111)
22:12:46.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.409057 20781 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.20.52.67@KRBTEST.COM'} at 127.20.52.67:60091
22:12:46.414 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
22:12:46.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.412770 20689 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
22:12:46.415 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

22:12:46.427 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

22:12:46.429 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

22:12:46.441 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.20.52.126"
      port: 46385
    }
    bound_http_address {
      host: "127.20.52.126"
      port: 33769
    }
  }
}

22:12:46.447 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

22:12:46.451 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.20.52.65"
      port: 42725
    }
    bound_http_address {
      host: "127.20.52.65"
      port: 40941
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.20.52.66"
      port: 33117
    }
    bound_http_address {
      host: "127.20.52.66"
      port: 45525
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.20.52.67"
      port: 43111
    }
    bound_http_address {
      host: "127.20.52.67"
      port: 36437
    }
  }
}

22:12:46.451 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
22:12:46.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.770762 21091 heartbeater.cc:503] Master 127.20.52.126:46385 was elected leader, sending a full tablet report...
22:12:46.797 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskKk0AbK/test-tmp/mini-kudu-cluster395190179061606114/krb5kdc/krb5cc
22:12:46.812 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
22:12:46.833 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
22:12:46.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.838203 20689 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu with pid 20883
22:12:46.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.892105 20755 connection.cc:535] server connection from 127.20.52.65:43729 recv error: Network error: failed to read from TLS socket (remote: 127.20.52.65:43729): Connection reset by peer (error 104)
22:12:46.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.892127 20689 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu with pid 21099
22:12:46.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.957115 20759 connection.cc:535] server connection from 127.20.52.66:43093 recv error: Network error: failed to read from TLS socket (remote: 127.20.52.66:43093): Connection reset by peer (error 104)
22:12:46.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.957458 20689 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu with pid 21307
22:12:46.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.973677 20757 connection.cc:535] server connection from 127.20.52.67:60091 recv error: Network error: failed to read from TLS socket (remote: 127.20.52.67:60091): Connection reset by peer (error 104)
22:12:46.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 22:12:46.974179 20689 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskKk0AbK/build/debug/bin/kudu with pid 20728
22:12:46.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 22:12:46.993607 20706 connection.cc:535] client connection to 127.20.52.126:46385 recv error: Network error: failed to read from TLS socket (remote: 127.20.52.126:46385): Connection reset by peer (error 104)
22:12:47.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T22:12:47Z chronyd exiting

Time: 5.002

OK (1 test)

