JUnit version 4.13.2
.16:11:06.472 [DEBUG - main] (TestNegotiationTLSv13.java:108) enabled TLS protocols: TLSv1.3 TLSv1.2 TLSv1.1 TLSv1
16:11:06.474 [DEBUG - main] (TestNegotiationTLSv13.java:110) supported TLS protocols: TLSv1.3 TLSv1.2 SSLv3 TLSv1.1 SSLv2Hello TLSv1
16:11:06.482 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task8CIWMx/test-tmp
16:11:06.484 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
16:11:06.486 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task8CIWMx/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
16:11:06.724 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 0
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148"
  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 {
  }
}

16:11:06.881 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
16:11:06.882 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

16:11:06.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:06.885159  8299 mini_oidc.cc:152] Starting JWKS server
16:11:06.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:06.888510  8299 webserver.cc:460] Webserver started at http://127.0.0.1:35363/ using document root <none> and password file <none>
16:11:06.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:06.888919  8299 mini_oidc.cc:189] Starting OIDC Discovery server
16:11:06.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:06.890569  8299 webserver.cc:460] Webserver started at http://127.0.0.1:38575/ using document root <none> and password file <none>
16:11:06.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:11:06Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
16:11:06.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:11:06Z Disabled control of system clock
16:11:06.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:06.937255  8299 external_mini_cluster.cc:1326] Running /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu
16:11:06.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu
16:11:06.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/wal
16:11:06.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/data
16:11:06.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:11:06.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:11:06.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:11:06.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:06.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:06.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:06.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/logs
16:11:06.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/data/info.pb
16:11:06.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.26.254:36163
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.26.254
16:11:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:06.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.26.212:42679
16:11:06.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:06.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:06.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:06.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:11:06.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.26.254:36163
16:11:06.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:11:06.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35363/jwks.json
16:11:06.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
16:11:06.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3 with env {}
16:11:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.222236  8316 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:11:07.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.222826  8316 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:11:07.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.223371  8316 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:11:07.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.254587  8316 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:11:07.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.254865  8316 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:11:07.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.255054  8316 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:11:07.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.255287  8316 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:11:07.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.255509  8316 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:11:07.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.255642  8316 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:35363/jwks.json
16:11:07.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:07.289705  8316 master_runner.cc:386] Master server non-default flags:
16:11:07.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:07.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.26.212:42679
16:11:07.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:07.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
16:11:07.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/data
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/wal
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.26.254:36163
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.26.254:36163
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35363/jwks.json
16:11:07.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3
16:11:07.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:07.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:07.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/data/info.pb
16:11:07.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.26.254
16:11:07.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:07.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:11:07.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:07.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:11:07.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:11:07.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:07.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/logs
16:11:07.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:07.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:11:07.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:11:07.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:11:07.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:11:07.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:11:07.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:11:07.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:12:52 UTC on ccycloud.quasar-tzrfpd.root.comops.site
16:11:07.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580143
16:11:07.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:11:07.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:07.290921  8316 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:11:07.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:07.292541  8316 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:11:07.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.310150  8335 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
16:11:08.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.310220  8331 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
16:11:08.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:07.310247  8328 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
16:11:08.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:07.311501  8316 server_base.cc:1034] running on GCE node
16:11:08.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.398670  8316 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
16:11:08.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.398912  8316 system_unsync_time.cc:38] NTP support is disabled. Clock error bounds will not be accurate. This configuration is not suitable for distributed clusters.
16:11:08.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.399152  8316 hybrid_clock.cc:648] HybridClock initialized: now 1786464668399119 us; error 0 us; skew 500 ppm
16:11:08.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.400133  8316 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:11:08.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.407637  8316 webserver.cc:460] Webserver started at http://127.8.26.254:35749/ using document root <none> and password file <none>
16:11:08.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.408612  8316 fs_manager.cc:359] Metadata directory not provided
16:11:08.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.408836  8316 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:11:08.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.409358  8316 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:11:08.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.414307  8316 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/data/instance:
16:11:08.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f90fa5a2aaa6411c949f63aab68dde63"
16:11:08.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:08 on dist-test-slave-fgb3"
16:11:08.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.415598  8316 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/wal/instance:
16:11:08.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f90fa5a2aaa6411c949f63aab68dde63"
16:11:08.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:08 on dist-test-slave-fgb3"
16:11:08.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.422634  8316 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.007s	sys 0.001s
16:11:08.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.428086  8348 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:11:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.429066  8316 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.003s
16:11:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.429389  8316 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/data,/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/wal
16:11:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f90fa5a2aaa6411c949f63aab68dde63"
16:11:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:08 on dist-test-slave-fgb3"
16:11:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.429751  8316 fs_report.cc:383] FS layout report
16:11:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:11:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/wal
16:11:08.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/wal
16:11:08.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8228303784827145148/master-0/data/data
16:11:08.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:11:08.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:11:08.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:11:08.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:11:08.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:11:08.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:11:08.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:11:08.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:11:08.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:11:08.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:11:08.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:11:08.490 [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
16:11:09.522 [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-task8CIWMx/build/tsan/bin/kudu: process exited with non-zero status 1"
}

16:11:10.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:11:10Z chronyd exiting
16:11:11.622 [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-task8CIWMx/build/tsan/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]
16:11:11.632 [INFO - main] (RandomUtils.java:49) Using random seed: 1786464671632
16:11:11.640 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
16:11:11.689 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
16:11:11.689 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task8CIWMx/test-tmp
16:11:11.690 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
16:11:11.690 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task8CIWMx/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
16:11:11.692 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455"
  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 {
  }
}

16:11:11.997 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
16:11:11.997 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

16:11:12.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.001951  8359 mini_oidc.cc:152] Starting JWKS server
16:11:12.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.005327  8359 webserver.cc:460] Webserver started at http://127.0.0.1:45783/ using document root <none> and password file <none>
16:11:12.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.005757  8359 mini_oidc.cc:189] Starting OIDC Discovery server
16:11:12.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.007822  8359 webserver.cc:460] Webserver started at http://127.0.0.1:46133/ using document root <none> and password file <none>
16:11:12.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
16:11:12.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/principal' for realm 'KRBTEST.COM',
16:11:12.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
16:11:12.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:12 dist-test-slave-fgb3 krb5kdc[8373](info): setting up network...
16:11:12.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
16:11:12.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:12 dist-test-slave-fgb3 krb5kdc[8373](info): set up 2 sockets
16:11:12.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:12 dist-test-slave-fgb3 krb5kdc[8373](info): commencing operation
16:11:12.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
16:11:13.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.472187  8359 mini_kdc.cc:121] Time spent starting KDC: real 1.440s	user 0.004s	sys 0.015s
16:11:13.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
16:11:13.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
16:11:13.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
16:11:13.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
16:11:13.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
16:11:13.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
16:11:13.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
16:11:13.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
16:11:13.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
16:11:13.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
16:11:13.568 [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-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/test-user.keytab.
16:11:13.568 [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-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/test-user.keytab.
16:11:13.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:13 dist-test-slave-fgb3 krb5kdc[8373](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786464673, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
16:11:13.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
16:11:13.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:11:13Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
16:11:13.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:11:13Z Disabled control of system clock
16:11:13.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.8.41.254@KRBTEST.COM; defaulting to no policy
16:11:13.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
16:11:13.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.8.41.254@KRBTEST.COM" created.
16:11:13.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
16:11:13.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.8.41.254 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.254.keytab.
16:11:13.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.8.41.254 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.254.keytab.
16:11:13.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.643958  8359 external_mini_cluster.cc:1326] Running /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu
16:11:13.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu
16:11:13.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/wal
16:11:13.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/data
16:11:13.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:11:13.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:11:13.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:11:13.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:13.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:13.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:13.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/logs
16:11:13.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/data/info.pb
16:11:13.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:13.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:11:13.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:11:13.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:11:13.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:11:13.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:13.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:13.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:13.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:11:13.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:11:13.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:11:13.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:11:13.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.41.254:35713
16:11:13.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.41.254
16:11:13.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:13.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.254.keytab
16:11:13.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.8.41.254
16:11:13.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
16:11:13.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
16:11:13.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
16:11:13.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.41.212:35749
16:11:13.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:13.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:13.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:13.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:11:13.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.41.254:35713
16:11:13.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:11:13.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45783/jwks.json
16:11:13.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
16:11:13.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
16:11:13.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
16:11:13.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.937592  8397 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:11:13.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.938150  8397 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:11:13.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.938804  8397 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:11:13.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.968401  8397 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:11:13.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.968708  8397 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
16:11:13.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.968930  8397 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:11:13.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.969118  8397 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:11:13.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.969298  8397 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:11:13.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.969486  8397 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:11:13.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.969623  8397 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45783/jwks.json
16:11:14.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.003784  8397 master_runner.cc:386] Master server non-default flags:
16:11:14.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:14.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.41.212:35749
16:11:14.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:14.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:14.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/data
16:11:14.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/wal
16:11:14.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:11:14.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.41.254:35713
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.254.keytab
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.8.41.254
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.41.254:35713
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:11:14.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45783/jwks.json
16:11:14.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
16:11:14.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
16:11:14.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
16:11:14.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
16:11:14.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:14.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:14.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/data/info.pb
16:11:14.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.41.254
16:11:14.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:14.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:11:14.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:14.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:11:14.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:11:14.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:14.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/logs
16:11:14.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:14.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:11:14.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:11:14.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:11:14.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:11:14.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:11:14.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:11:14.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:12:52 UTC on ccycloud.quasar-tzrfpd.root.comops.site
16:11:14.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580143
16:11:14.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:11:14.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.004918  8397 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:11:14.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.006039  8397 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:11:14.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:14.023424  8410 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
16:11:15.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:14.023458  8412 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
16:11:15.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:14.024253  8414 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
16:11:15.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.024856  8397 server_base.cc:1034] running on GCE node
16:11:15.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.113770  8397 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:11:15.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.116813  8397 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:11:15.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.118227  8397 hybrid_clock.cc:648] HybridClock initialized: now 1786464675118236 us; error 75 us; skew 500 ppm
16:11:15.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.119073  8397 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:11:15.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:15 dist-test-slave-fgb3 krb5kdc[8373](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786464675, etypes {rep=17 tkt=17 ses=17}, kudu/127.8.41.254@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
16:11:15.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.125031  8397 init.cc:377] Logged in from keytab as kudu/127.8.41.254@KRBTEST.COM (short username kudu)
16:11:15.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.130265  8397 webserver.cc:460] Webserver started at http://127.8.41.254:45397/ using document root <none> and password file <none>
16:11:15.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.131155  8397 fs_manager.cc:359] Metadata directory not provided
16:11:15.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.131341  8397 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:11:15.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.131881  8397 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:11:15.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.136896  8397 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/data/instance:
16:11:15.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "930c8ad79a814ebcb71c6e84c6d4af64"
16:11:15.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:15 on dist-test-slave-fgb3"
16:11:15.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.137928  8397 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/wal/instance:
16:11:15.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "930c8ad79a814ebcb71c6e84c6d4af64"
16:11:15.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:15 on dist-test-slave-fgb3"
16:11:15.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.144861  8397 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.005s	sys 0.000s
16:11:15.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.149971  8425 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:11:15.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.151021  8397 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
16:11:15.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.151293  8397 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/data,/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/wal
16:11:15.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "930c8ad79a814ebcb71c6e84c6d4af64"
16:11:15.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:15 on dist-test-slave-fgb3"
16:11:15.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.151692  8397 fs_report.cc:383] FS layout report
16:11:15.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:11:15.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/wal
16:11:15.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/wal
16:11:15.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/data/data
16:11:15.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:11:15.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:11:15.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:11:15.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:11:15.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:11:15.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:11:15.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:11:15.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:11:15.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:11:15.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:11:15.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:11:15.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.188944  8397 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:11:15.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.194581  8397 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
16:11:15.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.194993  8397 kserver.cc:163] Server-wide thread pool size limit: 3276
16:11:15.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.261721  8397 rpc_server.cc:307] RPC server started. Bound to: 127.8.41.254:35713
16:11:15.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.261801  8518 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.8.41.254:35713 every 8 connection(s)
16:11:15.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.264822  8397 server_base.cc:1166] Dumped server information to /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/data/info.pb
16:11:15.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.269817  8519 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
16:11:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.272835  8359 external_mini_cluster.cc:1388] Started /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu as pid 8397
16:11:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.273304  8359 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/master-0/wal/instance
16:11:15.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.288017  8519 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64: Bootstrap starting.
16:11:15.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.292994  8519 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64: Neither blocks nor log segments found. Creating new log.
16:11:15.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.294698  8519 log.cc:824] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64: Log is configured to *not* fsync() on all Append() calls
16:11:15.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.299391  8519 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64: No bootstrap required, opened a new log
16:11:15.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:15 dist-test-slave-fgb3 krb5kdc[8373](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786464673, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.8.41.254@KRBTEST.COM
16:11:15.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.320214  8521 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
16:11:15.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.278387 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.0.0.1:33750 (local address 127.8.41.254:35713)
16:11:15.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.280780 (+  2393us) server_negotiation.cc:206] Beginning negotiation
16:11:15.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.280819 (+    39us) server_negotiation.cc:399] Waiting for connection header
16:11:15.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.281799 (+   980us) server_negotiation.cc:407] Connection header received
16:11:15.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.291036 (+  9237us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
16:11:15.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.291072 (+    36us) server_negotiation.cc:461] Received NEGOTIATE request from client
16:11:15.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.291388 (+   316us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
16:11:15.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.291711 (+   323us) server_negotiation.cc:226] Negotiated authn=SASL
16:11:15.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.295499 (+  3788us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
16:11:15.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.297712 (+  2213us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
16:11:15.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.299853 (+  2141us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
16:11:15.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.300687 (+   834us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
16:11:15.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.300978 (+   291us) 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
16:11:15.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.307444 (+  6466us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
16:11:15.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.307466 (+    22us) server_negotiation.cc:881] Received SASL_INITIATE request from client
16:11:15.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.307492 (+    26us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
16:11:15.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.307592 (+   100us) server_negotiation.cc:922] calling sasl_server_start()
16:11:15.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.311557 (+  3965us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
16:11:15.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.313320 (+  1763us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
16:11:15.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.313356 (+    36us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.313381 (+    25us) server_negotiation.cc:967] calling sasl_server_step()
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.313675 (+   294us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.314755 (+  1080us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.314783 (+    28us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.314805 (+    22us) server_negotiation.cc:967] calling sasl_server_step()
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.315722 (+   917us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.316226 (+   504us) server_negotiation.cc:1035] Waiting for connection context
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.317707 (+  1481us) server_negotiation.cc:299] Negotiation successful
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:15.318286 (+   579us) negotiation.cc:327] Negotiation complete: OK
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":1896,"thread_start_us":1486,"threads_started":1}
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.321301  8519 raft_consensus.cc:348] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "930c8ad79a814ebcb71c6e84c6d4af64" member_type: VOTER last_known_addr { host: "127.8.41.254" port: 35713 } }
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.322196  8519 raft_consensus.cc:374] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:11:15.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.322507  8519 raft_consensus.cc:729] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 930c8ad79a814ebcb71c6e84c6d4af64, State: Initialized, Role: FOLLOWER
16:11:15.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.323350  8519 consensus_queue.cc:260] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [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: "930c8ad79a814ebcb71c6e84c6d4af64" member_type: VOTER last_known_addr { host: "127.8.41.254" port: 35713 } }
16:11:15.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.324036  8519 raft_consensus.cc:388] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
16:11:15.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.324366  8519 raft_consensus.cc:482] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
16:11:15.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.324729  8519 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [term 0 FOLLOWER]: Advancing to term 1
16:11:15.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.329046  8519 raft_consensus.cc:504] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "930c8ad79a814ebcb71c6e84c6d4af64" member_type: VOTER last_known_addr { host: "127.8.41.254" port: 35713 } }
16:11:15.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.329753  8519 leader_election.cc:302] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [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: 930c8ad79a814ebcb71c6e84c6d4af64; no voters: 
16:11:15.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.331499  8519 leader_election.cc:288] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [CANDIDATE]: Term 1 election: Requested vote from peers 
16:11:15.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.331825  8526 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [term 1 FOLLOWER]: Leader election won for term 1
16:11:15.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.334692  8526 raft_consensus.cc:686] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [term 1 LEADER]: Becoming Leader. State: Replica: 930c8ad79a814ebcb71c6e84c6d4af64, State: Running, Role: LEADER
16:11:15.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.335990  8519 sys_catalog.cc:564] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [sys.catalog]: configured and running, proceeding with master startup.
16:11:15.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.335748  8526 consensus_queue.cc:237] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [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: "930c8ad79a814ebcb71c6e84c6d4af64" member_type: VOTER last_known_addr { host: "127.8.41.254" port: 35713 } }
16:11:15.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.348745  8527 sys_catalog.cc:455] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "930c8ad79a814ebcb71c6e84c6d4af64" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "930c8ad79a814ebcb71c6e84c6d4af64" member_type: VOTER last_known_addr { host: "127.8.41.254" port: 35713 } } }
16:11:15.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.349900  8527 sys_catalog.cc:458] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [sys.catalog]: This master's current role is: LEADER
16:11:15.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.350175  8528 sys_catalog.cc:455] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 930c8ad79a814ebcb71c6e84c6d4af64. Latest consensus state: current_term: 1 leader_uuid: "930c8ad79a814ebcb71c6e84c6d4af64" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "930c8ad79a814ebcb71c6e84c6d4af64" member_type: VOTER last_known_addr { host: "127.8.41.254" port: 35713 } } }
16:11:15.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.351266  8528 sys_catalog.cc:458] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64 [sys.catalog]: This master's current role is: LEADER
16:11:15.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.361080  8544 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
16:11:15.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.368716  8544 catalog_manager.cc:1484] Initializing Kudu cluster ID...
16:11:15.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.383389  8544 catalog_manager.cc:1347] Generated new cluster ID: e777224e7f3c4b3694a3c6a0055ac74f
16:11:15.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.383687  8544 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
16:11:15.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.404204  8544 catalog_manager.cc:1370] Generated new certificate authority record
16:11:15.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.406672  8544 catalog_manager.cc:1504] Loading token signing keys...
16:11:15.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.428120  8544 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 930c8ad79a814ebcb71c6e84c6d4af64: Generated new TSK 0
16:11:15.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.428996  8544 catalog_manager.cc:1514] Initializing in-progress tserver states...
16:11:15.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.8.41.193@KRBTEST.COM; defaulting to no policy
16:11:15.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
16:11:15.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.8.41.193@KRBTEST.COM" created.
16:11:15.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
16:11:15.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.8.41.193 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.193.keytab.
16:11:15.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.8.41.193 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.193.keytab.
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.490617  8359 external_mini_cluster.cc:1326] Running /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/wal
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/data
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/logs
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/data/info.pb
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:11:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.41.193:0
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.41.193
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.41.193
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.41.254:35713
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.193.keytab
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.8.41.193
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.41.212:35749
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
16:11:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
16:11:15.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:15.797667  8572 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:11:15.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:15.798280  8572 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:11:15.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:15.798960  8572 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:11:15.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:15.833840  8572 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
16:11:15.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:15.834293  8572 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:11:15.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:15.835525  8572 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.41.193
16:11:15.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.871384  8572 tablet_server_runner.cc:78] Tablet server non-default flags:
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.41.212:35749
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/data
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/wal
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.193.keytab
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.8.41.193
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.41.193:0
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
16:11:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/data/info.pb
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.41.193
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.41.254:35713
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.41.193
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/logs
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:11:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:11:15.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:11:15.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:11:15.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:12:52 UTC on ccycloud.quasar-tzrfpd.root.comops.site
16:11:15.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580143
16:11:15.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:11:15.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.872834  8572 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:11:15.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.874222  8572 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:11:15.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:15.893508  8582 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
16:11:16.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.896138  8572 server_base.cc:1034] running on GCE node
16:11:16.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:15.893554  8581 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
16:11:16.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:15.895929  8584 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
16:11:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:16.988699  8572 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:11:16.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:16.991534  8572 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:11:16.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:16.993203  8572 hybrid_clock.cc:648] HybridClock initialized: now 1786464676993148 us; error 49 us; skew 500 ppm
16:11:16.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:16.994241  8572 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:11:17.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:16 dist-test-slave-fgb3 krb5kdc[8373](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786464676, etypes {rep=17 tkt=17 ses=17}, kudu/127.8.41.193@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
16:11:17.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.001207  8572 init.cc:377] Logged in from keytab as kudu/127.8.41.193@KRBTEST.COM (short username kudu)
16:11:17.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.007789  8572 webserver.cc:460] Webserver started at http://127.8.41.193:45989/ using document root <none> and password file <none>
16:11:17.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.008878  8572 fs_manager.cc:359] Metadata directory not provided
16:11:17.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.009080  8572 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:11:17.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.009512  8572 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:11:17.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.015759  8572 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/data/instance:
16:11:17.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4b9a483daaf24910b81c62feef966bd0"
16:11:17.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:17 on dist-test-slave-fgb3"
16:11:17.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.016930  8572 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/wal/instance:
16:11:17.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4b9a483daaf24910b81c62feef966bd0"
16:11:17.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:17 on dist-test-slave-fgb3"
16:11:17.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.023970  8572 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.004s	sys 0.004s
16:11:17.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.029220  8601 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:11:17.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.030193  8572 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
16:11:17.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.030545  8572 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/data,/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/wal
16:11:17.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4b9a483daaf24910b81c62feef966bd0"
16:11:17.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:17 on dist-test-slave-fgb3"
16:11:17.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.030982  8572 fs_report.cc:383] FS layout report
16:11:17.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:11:17.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/wal
16:11:17.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/wal
16:11:17.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/data/data
16:11:17.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:11:17.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:11:17.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:11:17.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:11:17.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:11:17.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:11:17.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:11:17.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:11:17.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:11:17.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:11:17.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:11:17.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.075904  8572 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:11:17.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.081545  8572 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
16:11:17.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.082044  8572 kserver.cc:163] Server-wide thread pool size limit: 3276
16:11:17.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.084666  8572 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:11:17.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.088585  8572 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:11:17.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.088783  8572 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:11:17.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.089080  8572 ts_tablet_manager.cc:610] Registered 0 tablets
16:11:17.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.089251  8572 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:11:17.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.217299  8572 rpc_server.cc:307] RPC server started. Bound to: 127.8.41.193:43389
16:11:17.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.217424  8787 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.8.41.193:43389 every 8 connection(s)
16:11:17.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.219944  8572 server_base.cc:1166] Dumped server information to /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/data/info.pb
16:11:17.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.226850  8359 external_mini_cluster.cc:1388] Started /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu as pid 8572
16:11:17.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.227340  8359 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-0/wal/instance
16:11:17.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:17 dist-test-slave-fgb3 krb5kdc[8373](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786464676, etypes {rep=17 tkt=17 ses=17}, kudu/127.8.41.193@KRBTEST.COM for kudu/127.8.41.254@KRBTEST.COM
16:11:17.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.8.41.194@KRBTEST.COM; defaulting to no policy
16:11:17.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
16:11:17.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.8.41.194@KRBTEST.COM" created.
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.258078  8791 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.224216 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.8.41.193:51777 (local address 127.8.41.254:35713)
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.225535 (+  1319us) server_negotiation.cc:206] Beginning negotiation
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.225556 (+    21us) server_negotiation.cc:399] Waiting for connection header
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.227255 (+  1699us) server_negotiation.cc:407] Connection header received
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.233071 (+  5816us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.233090 (+    19us) server_negotiation.cc:461] Received NEGOTIATE request from client
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.233246 (+   156us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.233377 (+   131us) server_negotiation.cc:226] Negotiated authn=SASL
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.236344 (+  2967us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.237453 (+  1109us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.240372 (+  2919us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.240969 (+   597us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
16:11:17.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.241161 (+   192us) 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
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.246299 (+  5138us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.246351 (+    52us) server_negotiation.cc:881] Received SASL_INITIATE request from client
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.246381 (+    30us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.246489 (+   108us) server_negotiation.cc:922] calling sasl_server_start()
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.250217 (+  3728us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.251799 (+  1582us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.251823 (+    24us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.251836 (+    13us) server_negotiation.cc:967] calling sasl_server_step()
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.252021 (+   185us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.252879 (+   858us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.252898 (+    19us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.252911 (+    13us) server_negotiation.cc:967] calling sasl_server_step()
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.253503 (+   592us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.253804 (+   301us) server_negotiation.cc:1035] Waiting for connection context
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.255500 (+  1696us) server_negotiation.cc:299] Negotiation successful
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.255907 (+   407us) negotiation.cc:327] Negotiation complete: OK
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":837,"thread_start_us":555,"threads_started":1}
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.258632  8792 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.224489 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.8.41.254:35713 (local address 127.8.41.193:51777)
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.226982 (+  2493us) negotiation.cc:107] Waiting for socket to connect
16:11:17.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.227072 (+    90us) client_negotiation.cc:174] Beginning negotiation
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.232716 (+  5644us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.233688 (+   972us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.233723 (+    35us) client_negotiation.cc:394] Received NEGOTIATE response from server
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.234874 (+  1151us) client_negotiation.cc:189] Negotiated authn=SASL
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.236048 (+  1174us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.236107 (+    59us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.237711 (+  1604us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.237737 (+    26us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.240122 (+  2385us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.240173 (+    51us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.241290 (+  1117us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
16:11:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.241322 (+    32us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.241759 (+   437us) 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
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.242693 (+   934us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.242757 (+    64us) client_negotiation.cc:656] calling sasl_client_start()
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.245842 (+  3085us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.250522 (+  4680us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.250553 (+    31us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.250576 (+    23us) client_negotiation.cc:760] calling sasl_client_step()
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.251465 (+   889us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.252294 (+   829us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.252312 (+    18us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.252326 (+    14us) client_negotiation.cc:760] calling sasl_client_step()
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.252596 (+   270us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.253885 (+  1289us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.253925 (+    40us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.254508 (+   583us) client_negotiation.cc:769] Sending connection context
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.255008 (+   500us) client_negotiation.cc:240] Negotiation successful
16:11:17.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:17.255495 (+   487us) negotiation.cc:327] Negotiation complete: OK
16:11:17.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":1928,"thread_start_us":1206,"threads_started":1}
16:11:17.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.261132  8789 heartbeater.cc:347] Connected to a master server at 127.8.41.254:35713
16:11:17.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.261583  8789 heartbeater.cc:464] Registering TS with master...
16:11:17.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.262753  8789 heartbeater.cc:511] Master 127.8.41.254:35713 requested a full tablet report, sending...
16:11:17.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.265812  8455 ts_manager.cc:194] Registered new tserver with Master: 4b9a483daaf24910b81c62feef966bd0 (127.8.41.193:43389)
16:11:17.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.268554  8455 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.8.41.193@KRBTEST.COM'} at 127.8.41.193:51777
16:11:17.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
16:11:17.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.8.41.194 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.194.keytab.
16:11:17.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.8.41.194 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.194.keytab.
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.280543  8359 external_mini_cluster.cc:1326] Running /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/wal
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/data
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/logs
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/data/info.pb
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:17.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:17.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:17.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:11:17.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:11:17.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.41.194:0
16:11:17.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.41.194
16:11:17.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.41.194
16:11:17.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:17.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.41.254:35713
16:11:17.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.194.keytab
16:11:17.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.8.41.194
16:11:17.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
16:11:17.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
16:11:17.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
16:11:17.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.41.212:35749
16:11:17.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:17.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:17.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:17.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
16:11:17.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
16:11:17.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
16:11:17.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.593145  8798 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:11:17.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.593608  8798 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:11:17.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.594172  8798 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:11:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.624320  8798 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
16:11:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.624631  8798 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:11:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.625504  8798 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.41.194
16:11:17.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.659359  8798 tablet_server_runner.cc:78] Tablet server non-default flags:
16:11:17.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:17.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.41.212:35749
16:11:17.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:17.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:17.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/data
16:11:17.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/wal
16:11:17.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.194.keytab
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.8.41.194
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.41.194:0
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/data/info.pb
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.41.194
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.41.254:35713
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.41.194
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/logs
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:12:52 UTC on ccycloud.quasar-tzrfpd.root.comops.site
16:11:17.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580143
16:11:17.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:11:17.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.660367  8798 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:11:17.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.661437  8798 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:11:17.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.678823  8806 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
16:11:18.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.273425  8789 heartbeater.cc:503] Master 127.8.41.254:35713 was elected leader, sending a full tablet report...
16:11:18.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.679548  8809 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
16:11:18.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.678928  8807 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
16:11:18.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:18.752081  8808 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
16:11:18.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.752214  8798 server_base.cc:1029] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
16:11:18.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.755997  8798 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:11:18.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.758186  8798 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:11:18.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.759598  8798 hybrid_clock.cc:648] HybridClock initialized: now 1786464678759564 us; error 37 us; skew 500 ppm
16:11:18.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.760426  8798 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:11:18.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:18 dist-test-slave-fgb3 krb5kdc[8373](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786464678, etypes {rep=17 tkt=17 ses=17}, kudu/127.8.41.194@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
16:11:18.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.766019  8798 init.cc:377] Logged in from keytab as kudu/127.8.41.194@KRBTEST.COM (short username kudu)
16:11:18.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.771227  8798 webserver.cc:460] Webserver started at http://127.8.41.194:34055/ using document root <none> and password file <none>
16:11:18.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.772065  8798 fs_manager.cc:359] Metadata directory not provided
16:11:18.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.772243  8798 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:11:18.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.772626  8798 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:11:18.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.777192  8798 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/data/instance:
16:11:18.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ec9d7c39921242ca88ad84f1180fa8c0"
16:11:18.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:18 on dist-test-slave-fgb3"
16:11:18.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.778306  8798 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/wal/instance:
16:11:18.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ec9d7c39921242ca88ad84f1180fa8c0"
16:11:18.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:18 on dist-test-slave-fgb3"
16:11:18.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.785071  8798 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.005s	sys 0.000s
16:11:18.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.790117  8823 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:11:18.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.791078  8798 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
16:11:18.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.791415  8798 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/data,/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/wal
16:11:18.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ec9d7c39921242ca88ad84f1180fa8c0"
16:11:18.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:18 on dist-test-slave-fgb3"
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.791764  8798 fs_report.cc:383] FS layout report
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/wal
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/wal
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/data/data
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:11:18.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:11:18.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:11:18.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.837925  8798 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:11:18.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.843466  8798 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
16:11:18.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.843946  8798 kserver.cc:163] Server-wide thread pool size limit: 3276
16:11:18.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.846513  8798 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:11:18.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.850520  8798 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:11:18.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.850718  8798 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:11:18.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.851001  8798 ts_tablet_manager.cc:610] Registered 0 tablets
16:11:18.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.851208  8798 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:11:18.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.982358  8798 rpc_server.cc:307] RPC server started. Bound to: 127.8.41.194:44429
16:11:18.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.982496  9002 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.8.41.194:44429 every 8 connection(s)
16:11:18.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.984990  8798 server_base.cc:1166] Dumped server information to /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/data/info.pb
16:11:18.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.994627  8359 external_mini_cluster.cc:1388] Started /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu as pid 8798
16:11:18.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.994962  8359 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-1/wal/instance
16:11:19.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:19 dist-test-slave-fgb3 krb5kdc[8373](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786464678, etypes {rep=17 tkt=17 ses=17}, kudu/127.8.41.194@KRBTEST.COM for kudu/127.8.41.254@KRBTEST.COM
16:11:19.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.8.41.195@KRBTEST.COM; defaulting to no policy
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.8.41.195@KRBTEST.COM" created.
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.021085  9005 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.989103 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.8.41.194:38469 (local address 127.8.41.254:35713)
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.990115 (+  1012us) server_negotiation.cc:206] Beginning negotiation
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.990134 (+    19us) server_negotiation.cc:399] Waiting for connection header
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.991961 (+  1827us) server_negotiation.cc:407] Connection header received
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.996641 (+  4680us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.996660 (+    19us) server_negotiation.cc:461] Received NEGOTIATE request from client
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.996825 (+   165us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.996996 (+   171us) server_negotiation.cc:226] Negotiated authn=SASL
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.999380 (+  2384us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.000442 (+  1062us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.003354 (+  2912us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.003962 (+   608us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.004146 (+   184us) 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
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.009787 (+  5641us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.009823 (+    36us) server_negotiation.cc:881] Received SASL_INITIATE request from client
16:11:19.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.009850 (+    27us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.009988 (+   138us) server_negotiation.cc:922] calling sasl_server_start()
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.014721 (+  4733us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.016009 (+  1288us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.016037 (+    28us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.016057 (+    20us) server_negotiation.cc:967] calling sasl_server_step()
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.016303 (+   246us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.017191 (+   888us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.017220 (+    29us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.017241 (+    21us) server_negotiation.cc:967] calling sasl_server_step()
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.017933 (+   692us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.018245 (+   312us) server_negotiation.cc:1035] Waiting for connection context
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.019383 (+  1138us) server_negotiation.cc:299] Negotiation successful
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.019660 (+   277us) negotiation.cc:327] Negotiation complete: OK
16:11:19.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":710,"thread_start_us":449,"threads_started":1}
16:11:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.025228  9007 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
16:11:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.989462 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.8.41.254:35713 (local address 127.8.41.194:38469)
16:11:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.991739 (+  2277us) negotiation.cc:107] Waiting for socket to connect
16:11:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.991807 (+    68us) client_negotiation.cc:174] Beginning negotiation
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.996330 (+  4523us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.997285 (+   955us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.997320 (+    35us) client_negotiation.cc:394] Received NEGOTIATE response from server
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.998114 (+   794us) client_negotiation.cc:189] Negotiated authn=SASL
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.999093 (+   979us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:18.999156 (+    63us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.000690 (+  1534us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.000715 (+    25us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.003106 (+  2391us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.003157 (+    51us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.004274 (+  1117us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.004304 (+    30us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.004779 (+   475us) 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
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.005816 (+  1037us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.005898 (+    82us) client_negotiation.cc:656] calling sasl_client_start()
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.009314 (+  3416us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.015014 (+  5700us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.015037 (+    23us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.015059 (+    22us) client_negotiation.cc:760] calling sasl_client_step()
16:11:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.015699 (+   640us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
16:11:19.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.016577 (+   878us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
16:11:19.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.016603 (+    26us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
16:11:19.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.016617 (+    14us) client_negotiation.cc:760] calling sasl_client_step()
16:11:19.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.016878 (+   261us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
16:11:19.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.018188 (+  1310us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
16:11:19.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.018233 (+    45us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
16:11:19.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.018733 (+   500us) client_negotiation.cc:769] Sending connection context
16:11:19.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.019090 (+   357us) client_negotiation.cc:240] Negotiation successful
16:11:19.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:19.019494 (+   404us) negotiation.cc:327] Negotiation complete: OK
16:11:19.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":1845,"thread_start_us":1169,"threads_started":1}
16:11:19.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.027813  9003 heartbeater.cc:347] Connected to a master server at 127.8.41.254:35713
16:11:19.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.028270  9003 heartbeater.cc:464] Registering TS with master...
16:11:19.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.029253  9003 heartbeater.cc:511] Master 127.8.41.254:35713 requested a full tablet report, sending...
16:11:19.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.031442  8455 ts_manager.cc:194] Registered new tserver with Master: ec9d7c39921242ca88ad84f1180fa8c0 (127.8.41.194:44429)
16:11:19.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.032861  8455 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.8.41.194@KRBTEST.COM'} at 127.8.41.194:38469
16:11:19.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
16:11:19.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.8.41.195 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.195.keytab.
16:11:19.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.8.41.195 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.195.keytab.
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.046679  8359 external_mini_cluster.cc:1326] Running /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/wal
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/data
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/logs
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/data/info.pb
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:19.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.41.195:0
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.41.195
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.41.195
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.41.254:35713
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.195.keytab
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.8.41.195
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.41.212:35749
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
16:11:19.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
16:11:19.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:19.346410  9014 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:11:19.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:19.346885  9014 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:11:19.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:19.347497  9014 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:11:19.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:19.376950  9014 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
16:11:19.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:19.377240  9014 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:11:19.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:19.378710  9014 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.41.195
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.415697  9014 tablet_server_runner.cc:78] Tablet server non-default flags:
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.41.212:35749
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/data
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/wal
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kudu_127.8.41.195.keytab
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.8.41.195
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.41.195:0
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/data/info.pb
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.41.195
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.41.254:35713
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.41.195
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/logs
16:11:19.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:19.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:11:19.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:11:19.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:11:19.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:11:19.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:11:19.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:11:19.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:12:52 UTC on ccycloud.quasar-tzrfpd.root.comops.site
16:11:19.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580143
16:11:19.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:11:19.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.416772  9014 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:11:19.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.417796  9014 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:11:19.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:19.435564  9024 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
16:11:20.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.036396  9003 heartbeater.cc:503] Master 127.8.41.254:35713 was elected leader, sending a full tablet report...
16:11:20.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:19.436487  9036 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
16:11:20.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.437987  9014 server_base.cc:1034] running on GCE node
16:11:20.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:19.435854  9022 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
16:11:20.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.519636  9014 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:11:20.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.522186  9014 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:11:20.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.523613  9014 hybrid_clock.cc:648] HybridClock initialized: now 1786464680523590 us; error 41 us; skew 500 ppm
16:11:20.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.524396  9014 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:11:20.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:20 dist-test-slave-fgb3 krb5kdc[8373](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786464680, etypes {rep=17 tkt=17 ses=17}, kudu/127.8.41.195@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
16:11:20.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.535070  9014 init.cc:377] Logged in from keytab as kudu/127.8.41.195@KRBTEST.COM (short username kudu)
16:11:20.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.540059  9014 webserver.cc:460] Webserver started at http://127.8.41.195:37267/ using document root <none> and password file <none>
16:11:20.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.540913  9014 fs_manager.cc:359] Metadata directory not provided
16:11:20.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.541096  9014 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:11:20.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.541478  9014 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:11:20.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.546260  9014 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/data/instance:
16:11:20.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "333b81727d9347169503619290d93bb8"
16:11:20.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:20 on dist-test-slave-fgb3"
16:11:20.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.547335  9014 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/wal/instance:
16:11:20.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "333b81727d9347169503619290d93bb8"
16:11:20.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:20 on dist-test-slave-fgb3"
16:11:20.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.554353  9014 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.003s	sys 0.004s
16:11:20.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.559502  9050 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:11:20.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.560532  9014 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.000s	sys 0.005s
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.560801  9014 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/data,/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/wal
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "333b81727d9347169503619290d93bb8"
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:20 on dist-test-slave-fgb3"
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.561088  9014 fs_report.cc:383] FS layout report
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/wal
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/wal
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/data/data
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:11:20.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:11:20.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:11:20.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:11:20.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:11:20.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:11:20.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.606561  9014 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:11:20.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.612289  9014 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
16:11:20.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.612694  9014 kserver.cc:163] Server-wide thread pool size limit: 3276
16:11:20.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.615170  9014 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:11:20.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.619037  9014 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:11:20.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.619231  9014 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:11:20.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.619416  9014 ts_tablet_manager.cc:610] Registered 0 tablets
16:11:20.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.619539  9014 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:11:20.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.751493  9014 rpc_server.cc:307] RPC server started. Bound to: 127.8.41.195:33185
16:11:20.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.751595  9235 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.8.41.195:33185 every 8 connection(s)
16:11:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.754060  9014 server_base.cc:1166] Dumped server information to /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/data/info.pb
16:11:20.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.760007  8359 external_mini_cluster.cc:1388] Started /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu as pid 9014
16:11:20.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.760504  8359 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/ts-2/wal/instance
16:11:20.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 16:11:20 dist-test-slave-fgb3 krb5kdc[8373](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786464680, etypes {rep=17 tkt=17 ses=17}, kudu/127.8.41.195@KRBTEST.COM for kudu/127.8.41.254@KRBTEST.COM
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.790207  9239 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.758601 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.8.41.195:54649 (local address 127.8.41.254:35713)
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.759554 (+   953us) server_negotiation.cc:206] Beginning negotiation
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.759569 (+    15us) server_negotiation.cc:399] Waiting for connection header
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.761765 (+  2196us) server_negotiation.cc:407] Connection header received
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.767767 (+  6002us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.767796 (+    29us) server_negotiation.cc:461] Received NEGOTIATE request from client
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.767974 (+   178us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.768109 (+   135us) server_negotiation.cc:226] Negotiated authn=SASL
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.770388 (+  2279us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.771548 (+  1160us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.773565 (+  2017us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.774193 (+   628us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
16:11:20.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.774464 (+   271us) 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
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.779476 (+  5012us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.779501 (+    25us) server_negotiation.cc:881] Received SASL_INITIATE request from client
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.779524 (+    23us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.779654 (+   130us) server_negotiation.cc:922] calling sasl_server_start()
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.783233 (+  3579us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.784485 (+  1252us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.784505 (+    20us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.784519 (+    14us) server_negotiation.cc:967] calling sasl_server_step()
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.784707 (+   188us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.785534 (+   827us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.785553 (+    19us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.785566 (+    13us) server_negotiation.cc:967] calling sasl_server_step()
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.786042 (+   476us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
16:11:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.786308 (+   266us) server_negotiation.cc:1035] Waiting for connection context
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.787597 (+  1289us) server_negotiation.cc:299] Negotiation successful
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.787987 (+   390us) negotiation.cc:327] Negotiation complete: OK
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":623,"thread_start_us":383,"threads_started":1}
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.790773  9240 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.759015 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.8.41.254:35713 (local address 127.8.41.195:54649)
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.761543 (+  2528us) negotiation.cc:107] Waiting for socket to connect
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.761608 (+    65us) client_negotiation.cc:174] Beginning negotiation
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.767455 (+  5847us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.768429 (+   974us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.768462 (+    33us) client_negotiation.cc:394] Received NEGOTIATE response from server
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.769223 (+   761us) client_negotiation.cc:189] Negotiated authn=SASL
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.770092 (+   869us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.770145 (+    53us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.771782 (+  1637us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.771803 (+    21us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.773336 (+  1533us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.773375 (+    39us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.774530 (+  1155us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.774565 (+    35us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.775009 (+   444us) 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
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.775967 (+   958us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.776032 (+    65us) client_negotiation.cc:656] calling sasl_client_start()
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.779050 (+  3018us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.783539 (+  4489us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.783561 (+    22us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.783582 (+    21us) client_negotiation.cc:760] calling sasl_client_step()
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.784207 (+   625us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
16:11:20.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.784982 (+   775us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
16:11:20.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.785000 (+    18us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
16:11:20.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.785014 (+    14us) client_negotiation.cc:760] calling sasl_client_step()
16:11:20.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.785263 (+   249us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
16:11:20.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.786348 (+  1085us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
16:11:20.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.786391 (+    43us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
16:11:20.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.786796 (+   405us) client_negotiation.cc:769] Sending connection context
16:11:20.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.787385 (+   589us) client_negotiation.cc:240] Negotiation successful
16:11:20.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 16:11:20.787852 (+   467us) negotiation.cc:327] Negotiation complete: OK
16:11:20.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":2100,"thread_start_us":2564,"threads_started":1}
16:11:20.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.792900  9236 heartbeater.cc:347] Connected to a master server at 127.8.41.254:35713
16:11:20.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.793299  9236 heartbeater.cc:464] Registering TS with master...
16:11:20.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.794466  9236 heartbeater.cc:511] Master 127.8.41.254:35713 requested a full tablet report, sending...
16:11:20.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.796761  8455 ts_manager.cc:194] Registered new tserver with Master: 333b81727d9347169503619290d93bb8 (127.8.41.195:33185)
16:11:20.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.798177  8455 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.8.41.195@KRBTEST.COM'} at 127.8.41.195:54649
16:11:20.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.809145  8359 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
16:11:20.815 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
16:11:20.817 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

16:11:20.825 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

16:11:20.826 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

16:11:20.835 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.8.41.254"
      port: 35713
    }
    bound_http_address {
      host: "127.8.41.254"
      port: 45397
    }
  }
}

16:11:20.841 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

16:11:20.845 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.8.41.193"
      port: 43389
    }
    bound_http_address {
      host: "127.8.41.193"
      port: 45989
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.8.41.194"
      port: 44429
    }
    bound_http_address {
      host: "127.8.41.194"
      port: 34055
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.8.41.195"
      port: 33185
    }
    bound_http_address {
      host: "127.8.41.195"
      port: 37267
    }
  }
}

16:11:20.845 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
16:11:21.049 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-task8CIWMx/test-tmp/mini-kudu-cluster8073148390945949455/krb5kdc/krb5cc
16:11:21.061 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
16:11:21.077 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
16:11:21.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.079840  8359 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu with pid 8572
16:11:21.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:21.113667  8426 connection.cc:535] server connection from 127.8.41.193:51777 recv error: Network error: failed to read from TLS socket (remote: 127.8.41.193:51777): Connection reset by peer (error 104)
16:11:21.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.114027  8359 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu with pid 8798
16:11:21.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:21.139353  8431 connection.cc:535] server connection from 127.8.41.194:38469 recv error: Network error: failed to read from TLS socket (remote: 127.8.41.194:38469): Connection reset by peer (error 104)
16:11:21.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.139732  8359 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu with pid 9014
16:11:21.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:21.182693  8431 connection.cc:535] server connection from 127.8.41.195:54649 recv error: Network error: failed to read from TLS socket (remote: 127.8.41.195:54649): Connection reset by peer (error 104)
16:11:21.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.183163  8359 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task8CIWMx/build/tsan/bin/kudu with pid 8397
16:11:22.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:21.212872  8370 connection.cc:535] client connection to 127.8.41.254:35713 recv error: Network error: failed to read from TLS socket (remote: 127.8.41.254:35713): Connection reset by peer (error 104)
16:11:22.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:11:22Z chronyd exiting

Time: 17.255

OK (1 test)

