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

06:39:51.358 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
06:39:51.359 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

06:39:51.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.361128 22193 mini_oidc.cc:152] Starting JWKS server
06:39:51.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.363292 22193 webserver.cc:460] Webserver started at http://127.0.0.1:46535/ using document root <none> and password file <none>
06:39:51.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.363412 22193 mini_oidc.cc:189] Starting OIDC Discovery server
06:39:51.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.363649 22193 webserver.cc:460] Webserver started at http://127.0.0.1:33443/ using document root <none> and password file <none>
06:39:51.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T06:39:51Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
06:39:51.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T06:39:51Z Disabled control of system clock
06:39:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.379127 22193 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu
06:39:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu
06:39:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/wal
06:39:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/data
06:39:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:39:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:39:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:39:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:51.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:51.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/logs
06:39:51.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/data/info.pb
06:39:51.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:51.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:39:51.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:39:51.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:39:51.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:39:51.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:51.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:51.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:51.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
06:39:51.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:39:51.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:39:51.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:39:51.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.172.126:37921
06:39:51.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.172.126
06:39:51.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:51.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.172.84:38187
06:39:51.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:51.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:51.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:51.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:39:51.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.172.126:37921
06:39:51.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:39:51.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46535/jwks.json
06:39:51.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
06:39:51.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3 with env {}
06:39:51.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.480741 22205 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:39:51.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.480988 22205 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:39:51.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.481045 22205 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:39:51.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.484623 22205 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
06:39:51.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.484696 22205 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:39:51.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.484740 22205 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
06:39:51.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.484762 22205 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
06:39:51.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.484783 22205 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
06:39:51.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.484800 22205 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:46535/jwks.json
06:39:51.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.489228 22205 master_runner.cc:386] Master server non-default flags:
06:39:51.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:51.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.172.84:38187
06:39:51.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:51.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
06:39:51.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/data
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/wal
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.172.126:37921
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.172.126:37921
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46535/jwks.json
06:39:51.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3
06:39:51.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:51.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:51.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/data/info.pb
06:39:51.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.172.126
06:39:51.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:51.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:39:51.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22205
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/logs
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:39:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:04:13 UTC on ccycloud.quasar-auftqw.root.comops.site
06:39:51.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492841
06:39:51.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.490350 22205 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:39:51.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.492034 22205 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:39:51.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.499773 22211 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
06:39:51.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.499812 22213 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
06:39:51.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.499862 22205 server_base.cc:1034] running on GCE node
06:39:51.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.499784 22210 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
06:39:51.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.500797 22205 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
06:39:51.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.500919 22205 system_unsync_time.cc:38] NTP support is disabled. Clock error bounds will not be accurate. This configuration is not suitable for distributed clusters.
06:39:51.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.500970 22205 hybrid_clock.cc:648] HybridClock initialized: now 1783492791500967 us; error 0 us; skew 500 ppm
06:39:51.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.506147 22205 webserver.cc:460] Webserver started at http://127.21.172.126:37225/ using document root <none> and password file <none>
06:39:51.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.506716 22205 fs_manager.cc:359] Metadata directory not provided
06:39:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.506815 22205 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:39:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.507046 22205 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:39:51.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.508819 22205 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/data/instance:
06:39:51.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e858e209a8af4b988feb86bdac2d66c6"
06:39:51.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:51 on dist-test-slave-dwzk"
06:39:51.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.509373 22205 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/wal/instance:
06:39:51.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e858e209a8af4b988feb86bdac2d66c6"
06:39:51.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:51 on dist-test-slave-dwzk"
06:39:51.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.512799 22205 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.002s	sys 0.001s
06:39:51.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.514930 22218 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:39:51.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.516108 22205 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
06:39:51.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.516244 22205 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/data,/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/wal
06:39:51.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e858e209a8af4b988feb86bdac2d66c6"
06:39:51.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:51 on dist-test-slave-dwzk"
06:39:51.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.516335 22205 fs_report.cc:383] FS layout report
06:39:51.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:39:51.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/wal
06:39:51.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/wal
06:39:51.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster7402778608934367291/master-0/data/data
06:39:51.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:39:51.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:39:51.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:39:51.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:39:51.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:39:51.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:39:51.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:39:51.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:39:51.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:39:51.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:39:51.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:39:51.530 [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
06:39:51.543 [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-taskbdSJOz/build/debug/bin/kudu: process exited with non-zero status 1"
}

06:39:51.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T06:39:51Z chronyd exiting
06:39:51.584 [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-taskbdSJOz/build/debug/bin/kudu: process exited with non-zero status 1
	at org.apache.kudu.test.cluster.MiniKuduCluster.sendRequestToCluster(MiniKuduCluster.java:199) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster.start(MiniKuduCluster.java:266) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster.access$300(MiniKuduCluster.java:85) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster$MiniKuduClusterBuilder.build(MiniKuduCluster.java:883) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.client.TestNegotiationTLSv13.isTLSv13SupportedByServerSide(TestNegotiationTLSv13.java:133) [test/:?]
	at org.apache.kudu.client.TestNegotiationTLSv13.<init>(TestNegotiationTLSv13.java:157) [test/:?]
	at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_362]
	at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) [?:1.8.0_362]
	at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) [?:1.8.0_362]
	at java.lang.reflect.Constructor.newInstance(Constructor.java:423) [?:1.8.0_362]
	at org.junit.runners.BlockJUnit4ClassRunner.createTest(BlockJUnit4ClassRunner.java:250) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.createTest(BlockJUnit4ClassRunner.java:260) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner$2.runReflectiveCall(BlockJUnit4ClassRunner.java:309) [junit-4.13.2.jar:4.13.2]
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.methodBlock(BlockJUnit4ClassRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.Suite.runChild(Suite.java:128) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.Suite.runChild(Suite.java:27) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36) [junit-4.13.2.jar:4.13.2]
06:39:51.592 [INFO - main] (RandomUtils.java:49) Using random seed: 1783492791592
06:39:51.600 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
06:39:51.643 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
06:39:51.644 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskbdSJOz/test-tmp
06:39:51.644 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
06:39:51.645 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskbdSJOz/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
06:39:51.646 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327"
  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 {
  }
}

06:39:51.749 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
06:39:51.749 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

06:39:51.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.750797 22220 mini_oidc.cc:152] Starting JWKS server
06:39:51.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.752476 22220 webserver.cc:460] Webserver started at http://127.0.0.1:42995/ using document root <none> and password file <none>
06:39:51.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.752591 22220 mini_oidc.cc:189] Starting OIDC Discovery server
06:39:51.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.752779 22220 webserver.cc:460] Webserver started at http://127.0.0.1:33439/ using document root <none> and password file <none>
06:39:51.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
06:39:51.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/principal' for realm 'KRBTEST.COM',
06:39:51.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
06:39:51.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:51 dist-test-slave-dwzk krb5kdc[22230](info): setting up network...
06:39:51.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
06:39:51.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:51 dist-test-slave-dwzk krb5kdc[22230](info): set up 2 sockets
06:39:51.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:51 dist-test-slave-dwzk krb5kdc[22230](info): commencing operation
06:39:51.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
06:39:52.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.701324 22220 mini_kdc.cc:121] Time spent starting KDC: real 0.942s	user 0.006s	sys 0.000s
06:39:52.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
06:39:52.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
06:39:52.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
06:39:52.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
06:39:52.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
06:39:52.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
06:39:52.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
06:39:52.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
06:39:52.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
06:39:52.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
06:39:52.768 [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-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/test-user.keytab.
06:39:52.768 [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-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/test-user.keytab.
06:39:52.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:52 dist-test-slave-dwzk krb5kdc[22230](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783492792, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
06:39:52.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
06:39:52.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T06:39:52Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
06:39:52.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T06:39:52Z Disabled control of system clock
06:39:52.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.21.179.62@KRBTEST.COM; defaulting to no policy
06:39:52.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:39:52.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.21.179.62@KRBTEST.COM" created.
06:39:52.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:39:52.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.179.62 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.62.keytab.
06:39:52.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.179.62 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.62.keytab.
06:39:52.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.807253 22220 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu
06:39:52.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu
06:39:52.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/wal
06:39:52.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/data
06:39:52.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:39:52.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:39:52.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:39:52.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/logs
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/data/info.pb
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.179.62:34079
06:39:52.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.179.62
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.62.keytab
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.179.62
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.179.20:33929
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.179.62:34079
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42995/jwks.json
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
06:39:52.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
06:39:52.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.905407 22243 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:39:52.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.905606 22243 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:39:52.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.905642 22243 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:39:52.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.908941 22243 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
06:39:52.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.908979 22243 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
06:39:52.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.908995 22243 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:39:52.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.909008 22243 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
06:39:52.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.909021 22243 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
06:39:52.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.909034 22243 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
06:39:52.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.909045 22243 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:42995/jwks.json
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.913846 22243 master_runner.cc:386] Master server non-default flags:
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.179.20:33929
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/data
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/wal
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.179.62:34079
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.62.keytab
06:39:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.179.62
06:39:52.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:52.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:52.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:39:52.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.179.62:34079
06:39:52.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:39:52.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:39:52.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:39:52.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42995/jwks.json
06:39:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:39:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
06:39:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
06:39:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
06:39:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/data/info.pb
06:39:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.179.62
06:39:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:39:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22243
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/logs
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:04:13 UTC on ccycloud.quasar-auftqw.root.comops.site
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492841
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.914682 22243 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:39:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.915864 22243 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:39:52.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.924054 22248 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
06:39:52.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.924093 22251 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
06:39:52.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.924081 22249 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
06:39:52.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.924340 22243 server_base.cc:1034] running on GCE node
06:39:52.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.924976 22243 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:39:52.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.925904 22243 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:39:52.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.927106 22243 hybrid_clock.cc:648] HybridClock initialized: now 1783492792927087 us; error 32 us; skew 500 ppm
06:39:52.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:52 dist-test-slave-dwzk krb5kdc[22230](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783492792, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.179.62@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
06:39:52.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.929653 22243 init.cc:377] Logged in from keytab as kudu/127.21.179.62@KRBTEST.COM (short username kudu)
06:39:52.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.930480 22243 webserver.cc:460] Webserver started at http://127.21.179.62:44319/ using document root <none> and password file <none>
06:39:52.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.931070 22243 fs_manager.cc:359] Metadata directory not provided
06:39:52.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.931162 22243 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:39:52.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.931382 22243 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:39:52.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.933043 22243 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/data/instance:
06:39:52.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "06bf128907b7498582fd09003190309d"
06:39:52.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-dwzk"
06:39:52.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.933686 22243 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/wal/instance:
06:39:52.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "06bf128907b7498582fd09003190309d"
06:39:52.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-dwzk"
06:39:52.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.937191 22243 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.002s	sys 0.002s
06:39:52.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.939198 22258 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:39:52.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.940294 22243 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
06:39:52.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.940419 22243 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/data,/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/wal
06:39:52.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "06bf128907b7498582fd09003190309d"
06:39:52.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-dwzk"
06:39:52.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.940521 22243 fs_report.cc:383] FS layout report
06:39:52.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:39:52.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/wal
06:39:52.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/wal
06:39:52.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/data/data
06:39:52.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:39:52.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:39:52.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:39:52.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:39:52.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:39:52.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:39:52.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:39:52.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:39:52.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:39:52.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:39:52.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:39:52.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.957788 22243 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:39:52.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.960210 22243 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
06:39:52.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.960384 22243 kserver.cc:163] Server-wide thread pool size limit: 3276
06:39:52.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.966499 22243 rpc_server.cc:307] RPC server started. Bound to: 127.21.179.62:34079
06:39:52.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.966713 22310 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.179.62:34079 every 8 connection(s)
06:39:52.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.967397 22243 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/data/info.pb
06:39:52.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.969851 22311 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
06:39:52.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.974220 22220 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu as pid 22243
06:39:52.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.974251 22311 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d: Bootstrap starting.
06:39:52.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.974377 22220 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/master-0/wal/instance
06:39:52.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.976421 22311 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d: Neither blocks nor log segments found. Creating new log.
06:39:52.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.977239 22311 log.cc:824] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d: Log is configured to *not* fsync() on all Append() calls
06:39:52.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.978904 22311 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d: No bootstrap required, opened a new log
06:39:52.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.982440 22311 raft_consensus.cc:348] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "06bf128907b7498582fd09003190309d" member_type: VOTER last_known_addr { host: "127.21.179.62" port: 34079 } }
06:39:52.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.982616 22311 raft_consensus.cc:374] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:39:52.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.982651 22311 raft_consensus.cc:729] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 06bf128907b7498582fd09003190309d, State: Initialized, Role: FOLLOWER
06:39:52.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.983039 22311 consensus_queue.cc:260] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [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: "06bf128907b7498582fd09003190309d" member_type: VOTER last_known_addr { host: "127.21.179.62" port: 34079 } }
06:39:52.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.983441 22311 raft_consensus.cc:388] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
06:39:52.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.983698 22311 raft_consensus.cc:482] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
06:39:52.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.984009 22311 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [term 0 FOLLOWER]: Advancing to term 1
06:39:52.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.985150 22311 raft_consensus.cc:504] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "06bf128907b7498582fd09003190309d" member_type: VOTER last_known_addr { host: "127.21.179.62" port: 34079 } }
06:39:52.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.985476 22311 leader_election.cc:302] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [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: 06bf128907b7498582fd09003190309d; no voters: 
06:39:52.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.985774 22311 leader_election.cc:288] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [CANDIDATE]: Term 1 election: Requested vote from peers 
06:39:52.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.986881 22311 sys_catalog.cc:564] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [sys.catalog]: configured and running, proceeding with master startup.
06:39:52.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.988981 22317 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [term 1 FOLLOWER]: Leader election won for term 1
06:39:52.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.989445 22317 raft_consensus.cc:686] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [term 1 LEADER]: Becoming Leader. State: Replica: 06bf128907b7498582fd09003190309d, State: Running, Role: LEADER
06:39:52.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.989987 22317 consensus_queue.cc:237] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [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: "06bf128907b7498582fd09003190309d" member_type: VOTER last_known_addr { host: "127.21.179.62" port: 34079 } }
06:39:52.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:52 dist-test-slave-dwzk krb5kdc[22230](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783492792, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.21.179.62@KRBTEST.COM
06:39:52.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.992659 22316 sys_catalog.cc:455] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "06bf128907b7498582fd09003190309d" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "06bf128907b7498582fd09003190309d" member_type: VOTER last_known_addr { host: "127.21.179.62" port: 34079 } } }
06:39:52.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.992774 22316 sys_catalog.cc:458] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [sys.catalog]: This master's current role is: LEADER
06:39:52.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.993981 22329 sys_catalog.cc:455] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [sys.catalog]: SysCatalogTable state changed. Reason: New leader 06bf128907b7498582fd09003190309d. Latest consensus state: current_term: 1 leader_uuid: "06bf128907b7498582fd09003190309d" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "06bf128907b7498582fd09003190309d" member_type: VOTER last_known_addr { host: "127.21.179.62" port: 34079 } } }
06:39:52.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.994272 22328 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
06:39:52.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.994352 22328 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
06:39:52.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.994411 22332 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
06:39:52.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.994289 22329 sys_catalog.cc:458] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d [sys.catalog]: This master's current role is: LEADER
06:39:52.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.995182 22332 catalog_manager.cc:1484] Initializing Kudu cluster ID...
06:39:52.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.997757 22313 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.977178 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.0.0.1:60576 (local address 127.21.179.62:34079)
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.977695 (+   517us) server_negotiation.cc:206] Beginning negotiation
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.977713 (+    18us) server_negotiation.cc:399] Waiting for connection header
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.978459 (+   746us) server_negotiation.cc:407] Connection header received
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.980702 (+  2243us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.980719 (+    17us) server_negotiation.cc:461] Received NEGOTIATE request from client
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.981010 (+   291us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.981384 (+   374us) server_negotiation.cc:226] Negotiated authn=SASL
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.983475 (+  2091us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.984860 (+  1385us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.986553 (+  1693us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.987153 (+   600us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.987324 (+   171us) 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
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.991981 (+  4657us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.991988 (+     7us) server_negotiation.cc:881] Received SASL_INITIATE request from client
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.992002 (+    14us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
06:39:52.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.992033 (+    31us) server_negotiation.cc:922] calling sasl_server_start()
06:39:52.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.994466 (+  2433us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:39:52.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.995166 (+   700us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:39:52.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.995171 (+     5us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:39:52.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.995174 (+     3us) server_negotiation.cc:967] calling sasl_server_step()
06:39:52.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.995332 (+   158us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:39:52.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.995789 (+   457us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:39:53.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.995793 (+     4us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:39:53.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.995795 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
06:39:53.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.996160 (+   365us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
06:39:53.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.996377 (+   217us) server_negotiation.cc:1035] Waiting for connection context
06:39:53.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.996859 (+   482us) server_negotiation.cc:299] Negotiation successful
06:39:53.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:52.997031 (+   172us) negotiation.cc:327] Negotiation complete: OK
06:39:53.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":372,"thread_start_us":118,"threads_started":1}
06:39:53.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.006707 22332 catalog_manager.cc:1347] Generated new cluster ID: 072799ce0c6c4397a133be808857edf7
06:39:53.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.006760 22332 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
06:39:53.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.021456 22332 catalog_manager.cc:1370] Generated new certificate authority record
06:39:53.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.022490 22332 catalog_manager.cc:1504] Loading token signing keys...
06:39:53.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.027554 22332 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 06bf128907b7498582fd09003190309d: Generated new TSK 0
06:39:53.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.028131 22332 catalog_manager.cc:1514] Initializing in-progress tserver states...
06:39:53.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.21.179.1@KRBTEST.COM; defaulting to no policy
06:39:53.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:39:53.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.21.179.1@KRBTEST.COM" created.
06:39:53.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:39:53.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.179.1 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.1.keytab.
06:39:53.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.179.1 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.1.keytab.
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.052883 22220 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/wal
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/data
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/logs
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/data/info.pb
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:39:53.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.179.1:0
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.179.1
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.179.1
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.179.62:34079
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.1.keytab
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.179.1
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.179.20:33929
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
06:39:53.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
06:39:53.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.152202 22337 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:39:53.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.152396 22337 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:39:53.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.152431 22337 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:39:53.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.156203 22337 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
06:39:53.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.156245 22337 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:39:53.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.156309 22337 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.179.1
06:39:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.160912 22337 tablet_server_runner.cc:78] Tablet server non-default flags:
06:39:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.179.20:33929
06:39:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/data
06:39:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/wal
06:39:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
06:39:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
06:39:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.1.keytab
06:39:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.179.1
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.179.1:0
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/data/info.pb
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.179.1
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.179.62:34079
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22337
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:39:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.179.1
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/logs
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:04:13 UTC on ccycloud.quasar-auftqw.root.comops.site
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492841
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.161911 22337 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:39:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.162948 22337 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:39:53.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.171406 22345 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
06:39:53.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.171392 22342 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
06:39:53.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.171451 22343 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
06:39:53.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.171510 22337 server_base.cc:1034] running on GCE node
06:39:53.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.172173 22337 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:39:53.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.172782 22337 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:39:53.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.173961 22337 hybrid_clock.cc:648] HybridClock initialized: now 1783492793173933 us; error 39 us; skew 500 ppm
06:39:53.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:53 dist-test-slave-dwzk krb5kdc[22230](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783492793, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.179.1@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
06:39:53.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.176550 22337 init.cc:377] Logged in from keytab as kudu/127.21.179.1@KRBTEST.COM (short username kudu)
06:39:53.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.177366 22337 webserver.cc:460] Webserver started at http://127.21.179.1:46265/ using document root <none> and password file <none>
06:39:53.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.177862 22337 fs_manager.cc:359] Metadata directory not provided
06:39:53.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.177917 22337 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:39:53.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.178112 22337 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:39:53.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.180169 22337 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/data/instance:
06:39:53.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "39cd3f222d2842e3b72c28eeb31a743c"
06:39:53.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-dwzk"
06:39:53.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.180805 22337 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/wal/instance:
06:39:53.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "39cd3f222d2842e3b72c28eeb31a743c"
06:39:53.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-dwzk"
06:39:53.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.184854 22337 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.003s	sys 0.000s
06:39:53.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.186861 22352 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.188014 22337 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.000s	sys 0.002s
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.188107 22337 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/data,/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/wal
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "39cd3f222d2842e3b72c28eeb31a743c"
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-dwzk"
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.188189 22337 fs_report.cc:383] FS layout report
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/wal
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/wal
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/data/data
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:39:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:39:53.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:39:53.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:39:53.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:39:53.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:39:53.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:39:53.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:39:53.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.202324 22337 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:39:53.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.204921 22337 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
06:39:53.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.205135 22337 kserver.cc:163] Server-wide thread pool size limit: 3276
06:39:53.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.205634 22337 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
06:39:53.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.206373 22337 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:39:53.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.206418 22337 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:39:53.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.206453 22337 ts_tablet_manager.cc:610] Registered 0 tablets
06:39:53.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.206468 22337 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:39:53.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.214174 22337 rpc_server.cc:307] RPC server started. Bound to: 127.21.179.1:36559
06:39:53.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.214243 22465 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.179.1:36559 every 8 connection(s)
06:39:53.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.214964 22337 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/data/info.pb
06:39:53.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.218585 22220 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu as pid 22337
06:39:53.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.218698 22220 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-0/wal/instance
06:39:53.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:53 dist-test-slave-dwzk krb5kdc[22230](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783492793, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.179.1@KRBTEST.COM for kudu/127.21.179.62@KRBTEST.COM
06:39:53.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.21.179.2@KRBTEST.COM; defaulting to no policy
06:39:53.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.227519 22313 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:39:53.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.216591 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.21.179.1:54865 (local address 127.21.179.62:34079)
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.216716 (+   125us) server_negotiation.cc:206] Beginning negotiation
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.216720 (+     4us) server_negotiation.cc:399] Waiting for connection header
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.217451 (+   731us) server_negotiation.cc:407] Connection header received
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.218627 (+  1176us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.218630 (+     3us) server_negotiation.cc:461] Received NEGOTIATE request from client
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.218691 (+    61us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.218781 (+    90us) server_negotiation.cc:226] Negotiated authn=SASL
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.219925 (+  1144us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.220628 (+   703us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.221870 (+  1242us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.222054 (+   184us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.222125 (+    71us) 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
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.224374 (+  2249us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.224378 (+     4us) server_negotiation.cc:881] Received SASL_INITIATE request from client
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.224380 (+     2us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.224405 (+    25us) server_negotiation.cc:922] calling sasl_server_start()
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.225691 (+  1286us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226163 (+   472us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226168 (+     5us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226169 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226237 (+    68us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226568 (+   331us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226571 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226572 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
06:39:53.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226727 (+   155us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226836 (+   109us) server_negotiation.cc:1035] Waiting for connection context
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.227310 (+   474us) server_negotiation.cc:299] Negotiation successful
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.227389 (+    79us) negotiation.cc:327] Negotiation complete: OK
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":49}
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.228516 22468 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.216894 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.21.179.62:34079 (local address 127.21.179.1:54865)
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.217326 (+   432us) negotiation.cc:107] Waiting for socket to connect
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.217362 (+    36us) client_negotiation.cc:174] Beginning negotiation
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.218437 (+  1075us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.218928 (+   491us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.218934 (+     6us) client_negotiation.cc:394] Received NEGOTIATE response from server
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.219277 (+   343us) client_negotiation.cc:189] Negotiated authn=SASL
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.219800 (+   523us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.219817 (+    17us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.220751 (+   934us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.220753 (+     2us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.221740 (+   987us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.221753 (+    13us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.222190 (+   437us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.222195 (+     5us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:39:53.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.222380 (+   185us) 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
06:39:53.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.223001 (+   621us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
06:39:53.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.223014 (+    13us) client_negotiation.cc:656] calling sasl_client_start()
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.224197 (+  1183us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.225822 (+  1625us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.225827 (+     5us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.225838 (+    11us) client_negotiation.cc:760] calling sasl_client_step()
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226046 (+   208us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226340 (+   294us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226343 (+     3us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226345 (+     2us) client_negotiation.cc:760] calling sasl_client_step()
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226461 (+   116us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226845 (+   384us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.226852 (+     7us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.227042 (+   190us) client_negotiation.cc:769] Sending connection context
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.227634 (+   592us) client_negotiation.cc:240] Negotiation successful
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.227801 (+   167us) negotiation.cc:327] Negotiation complete: OK
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":280,"thread_start_us":152,"threads_started":1}
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.229629 22466 heartbeater.cc:347] Connected to a master server at 127.21.179.62:34079
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.229807 22466 heartbeater.cc:464] Registering TS with master...
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.230149 22466 heartbeater.cc:511] Master 127.21.179.62:34079 requested a full tablet report, sending...
06:39:53.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.231734 22275 ts_manager.cc:194] Registered new tserver with Master: 39cd3f222d2842e3b72c28eeb31a743c (127.21.179.1:36559)
06:39:53.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.232805 22275 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.21.179.1@KRBTEST.COM'} at 127.21.179.1:54865
06:39:53.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:39:53.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.21.179.2@KRBTEST.COM" created.
06:39:53.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:39:53.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.179.2 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.2.keytab.
06:39:53.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.179.2 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.2.keytab.
06:39:53.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.247686 22220 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu
06:39:53.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu
06:39:53.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/wal
06:39:53.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/data
06:39:53.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:39:53.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/logs
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/data/info.pb
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.179.2:0
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.179.2
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.179.2
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.179.62:34079
06:39:53.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.2.keytab
06:39:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.179.2
06:39:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:39:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
06:39:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
06:39:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.179.20:33929
06:39:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
06:39:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
06:39:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
06:39:53.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.344115 22471 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:39:53.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.344350 22471 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:39:53.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.344386 22471 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:39:53.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.348248 22471 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
06:39:53.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.348299 22471 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:39:53.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.348351 22471 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.179.2
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.352926 22471 tablet_server_runner.cc:78] Tablet server non-default flags:
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.179.20:33929
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/data
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/wal
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.2.keytab
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.179.2
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.179.2:0
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/data/info.pb
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.179.2
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.179.62:34079
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22471
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:53.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.179.2
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/logs
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:04:13 UTC on ccycloud.quasar-auftqw.root.comops.site
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492841
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.353734 22471 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:39:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.354593 22471 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:39:53.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.363230 22476 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
06:39:53.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.363229 22477 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
06:39:53.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.363288 22479 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
06:39:53.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.363444 22471 server_base.cc:1034] running on GCE node
06:39:53.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.364014 22471 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:39:53.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.364600 22471 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:39:53.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.365787 22471 hybrid_clock.cc:648] HybridClock initialized: now 1783492793365771 us; error 34 us; skew 500 ppm
06:39:53.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:53 dist-test-slave-dwzk krb5kdc[22230](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783492793, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.179.2@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
06:39:53.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.368467 22471 init.cc:377] Logged in from keytab as kudu/127.21.179.2@KRBTEST.COM (short username kudu)
06:39:53.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.369189 22471 webserver.cc:460] Webserver started at http://127.21.179.2:41909/ using document root <none> and password file <none>
06:39:53.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.369589 22471 fs_manager.cc:359] Metadata directory not provided
06:39:53.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.369635 22471 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:39:53.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.369773 22471 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:39:53.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.371313 22471 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/data/instance:
06:39:53.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ec4d9fd9f34547338bd35d8627ab66b1"
06:39:53.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-dwzk"
06:39:53.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.371793 22471 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/wal/instance:
06:39:53.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ec4d9fd9f34547338bd35d8627ab66b1"
06:39:53.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-dwzk"
06:39:53.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.374845 22471 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.005s	sys 0.000s
06:39:53.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.376929 22486 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.378053 22471 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.378131 22471 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/data,/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/wal
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ec4d9fd9f34547338bd35d8627ab66b1"
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-dwzk"
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.378186 22471 fs_report.cc:383] FS layout report
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/wal
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/wal
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/data/data
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:39:53.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:39:53.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.408715 22471 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:39:53.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.411015 22471 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
06:39:53.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.411142 22471 kserver.cc:163] Server-wide thread pool size limit: 3276
06:39:53.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.411572 22471 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
06:39:53.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.412382 22471 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:39:53.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.412422 22471 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:39:53.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.412453 22471 ts_tablet_manager.cc:610] Registered 0 tablets
06:39:53.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.412467 22471 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:39:53.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.419931 22471 rpc_server.cc:307] RPC server started. Bound to: 127.21.179.2:38625
06:39:53.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.419953 22599 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.179.2:38625 every 8 connection(s)
06:39:53.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.420888 22471 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/data/info.pb
06:39:53.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.422386 22220 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu as pid 22471
06:39:53.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.422484 22220 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-1/wal/instance
06:39:53.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:53 dist-test-slave-dwzk krb5kdc[22230](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783492793, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.179.2@KRBTEST.COM for kudu/127.21.179.62@KRBTEST.COM
06:39:53.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.21.179.3@KRBTEST.COM; defaulting to no policy
06:39:53.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:39:53.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.21.179.3@KRBTEST.COM" created.
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.435153 22313 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.423119 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.21.179.2:43171 (local address 127.21.179.62:34079)
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.423414 (+   295us) server_negotiation.cc:206] Beginning negotiation
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.423418 (+     4us) server_negotiation.cc:399] Waiting for connection header
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.423675 (+   257us) server_negotiation.cc:407] Connection header received
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.425172 (+  1497us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.425176 (+     4us) server_negotiation.cc:461] Received NEGOTIATE request from client
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.425226 (+    50us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.425307 (+    81us) server_negotiation.cc:226] Negotiated authn=SASL
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.426578 (+  1271us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.427134 (+   556us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.428854 (+  1720us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.429120 (+   266us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.429201 (+    81us) 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
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.431800 (+  2599us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.431804 (+     4us) server_negotiation.cc:881] Received SASL_INITIATE request from client
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.431807 (+     3us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.431830 (+    23us) server_negotiation.cc:922] calling sasl_server_start()
06:39:53.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433199 (+  1369us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433688 (+   489us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433693 (+     5us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433694 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433769 (+    75us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.434128 (+   359us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.434131 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.434132 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.434301 (+   169us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.434412 (+   111us) server_negotiation.cc:1035] Waiting for connection context
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.434961 (+   549us) server_negotiation.cc:299] Negotiation successful
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.435040 (+    79us) negotiation.cc:327] Negotiation complete: OK
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":230}
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.436148 22602 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.423063 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.21.179.62:34079 (local address 127.21.179.2:43171)
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.423540 (+   477us) negotiation.cc:107] Waiting for socket to connect
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.423588 (+    48us) client_negotiation.cc:174] Beginning negotiation
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.424964 (+  1376us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.425466 (+   502us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.425473 (+     7us) client_negotiation.cc:394] Received NEGOTIATE response from server
06:39:53.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.425895 (+   422us) client_negotiation.cc:189] Negotiated authn=SASL
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.426428 (+   533us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.426449 (+    21us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.427261 (+   812us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.427267 (+     6us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.428718 (+  1451us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.428733 (+    15us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.429270 (+   537us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.429284 (+    14us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.429502 (+   218us) 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
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.430077 (+   575us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.430096 (+    19us) client_negotiation.cc:656] calling sasl_client_start()
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.431579 (+  1483us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433333 (+  1754us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433338 (+     5us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433349 (+    11us) client_negotiation.cc:760] calling sasl_client_step()
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433564 (+   215us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:39:53.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433880 (+   316us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433883 (+     3us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.433885 (+     2us) client_negotiation.cc:760] calling sasl_client_step()
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.434010 (+   125us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.434421 (+   411us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.434427 (+     6us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.434639 (+   212us) client_negotiation.cc:769] Sending connection context
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.434905 (+   266us) client_negotiation.cc:240] Negotiation successful
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.435120 (+   215us) negotiation.cc:327] Negotiation complete: OK
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":276,"thread_start_us":123,"threads_started":1}
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.437271 22600 heartbeater.cc:347] Connected to a master server at 127.21.179.62:34079
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.437470 22600 heartbeater.cc:464] Registering TS with master...
06:39:53.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.437934 22600 heartbeater.cc:511] Master 127.21.179.62:34079 requested a full tablet report, sending...
06:39:53.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.438917 22275 ts_manager.cc:194] Registered new tserver with Master: ec4d9fd9f34547338bd35d8627ab66b1 (127.21.179.2:38625)
06:39:53.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.439440 22275 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.21.179.2@KRBTEST.COM'} at 127.21.179.2:43171
06:39:53.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:39:53.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.179.3 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.3.keytab.
06:39:53.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.179.3 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.3.keytab.
06:39:53.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.451614 22220 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu
06:39:53.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu
06:39:53.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/wal
06:39:53.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/data
06:39:53.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/logs
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/data/info.pb
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:39:53.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.179.3:0
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.179.3
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.179.3
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.179.62:34079
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.3.keytab
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.179.3
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.179.20:33929
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
06:39:53.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
06:39:53.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.553915 22605 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:39:53.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.554123 22605 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:39:53.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.554162 22605 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:39:53.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.557983 22605 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
06:39:53.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.558028 22605 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:39:53.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.558080 22605 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.179.3
06:39:53.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.562638 22605 tablet_server_runner.cc:78] Tablet server non-default flags:
06:39:53.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:53.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.179.20:33929
06:39:53.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/data
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/wal
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kudu_127.21.179.3.keytab
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.179.3
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.179.3:0
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/data/info.pb
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.179.3
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.179.62:34079
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22605
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.179.3
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/logs
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:39:53.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:39:53.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:39:53.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:04:13 UTC on ccycloud.quasar-auftqw.root.comops.site
06:39:53.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492841
06:39:53.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.563565 22605 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:39:53.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.564845 22605 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:39:53.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.574184 22611 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
06:39:53.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.574353 22613 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
06:39:53.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.574409 22605 server_base.cc:1034] running on GCE node
06:39:53.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.574204 22610 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
06:39:53.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.575093 22605 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:39:53.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.575678 22605 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:39:53.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.576934 22605 hybrid_clock.cc:648] HybridClock initialized: now 1783492793576908 us; error 27 us; skew 500 ppm
06:39:53.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:53 dist-test-slave-dwzk krb5kdc[22230](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783492793, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.179.3@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
06:39:53.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.579638 22605 init.cc:377] Logged in from keytab as kudu/127.21.179.3@KRBTEST.COM (short username kudu)
06:39:53.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.580519 22605 webserver.cc:460] Webserver started at http://127.21.179.3:35539/ using document root <none> and password file <none>
06:39:53.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.581101 22605 fs_manager.cc:359] Metadata directory not provided
06:39:53.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.581189 22605 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:39:53.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.581452 22605 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:39:53.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.583073 22605 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/data/instance:
06:39:53.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "737ad36a4215437abb6b7303741968c1"
06:39:53.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-dwzk"
06:39:53.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.583629 22605 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/wal/instance:
06:39:53.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "737ad36a4215437abb6b7303741968c1"
06:39:53.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-dwzk"
06:39:53.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.586790 22605 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.005s	sys 0.000s
06:39:53.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.588951 22620 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.590065 22605 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.590181 22605 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/data,/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/wal
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "737ad36a4215437abb6b7303741968c1"
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-dwzk"
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.590293 22605 fs_report.cc:383] FS layout report
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/wal
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/wal
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/data/data
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:39:53.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:39:53.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.602532 22605 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:39:53.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.604847 22605 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
06:39:53.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.605022 22605 kserver.cc:163] Server-wide thread pool size limit: 3276
06:39:53.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.605580 22605 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
06:39:53.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.606281 22605 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:39:53.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.606501 22605 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:39:53.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.606585 22605 ts_tablet_manager.cc:610] Registered 0 tablets
06:39:53.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.606606 22605 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:39:53.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.614426 22605 rpc_server.cc:307] RPC server started. Bound to: 127.21.179.3:41603
06:39:53.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.614450 22733 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.179.3:41603 every 8 connection(s)
06:39:53.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.615193 22605 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/data/info.pb
06:39:53.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.616741 22220 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu as pid 22605
06:39:53.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.616837 22220 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/ts-2/wal/instance
06:39:53.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 06:39:53 dist-test-slave-dwzk krb5kdc[22230](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783492793, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.179.3@KRBTEST.COM for kudu/127.21.179.62@KRBTEST.COM
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.627197 22313 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.616912 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.21.179.3:54411 (local address 127.21.179.62:34079)
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.617062 (+   150us) server_negotiation.cc:206] Beginning negotiation
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.617067 (+     5us) server_negotiation.cc:399] Waiting for connection header
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.617934 (+   867us) server_negotiation.cc:407] Connection header received
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.619203 (+  1269us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.619206 (+     3us) server_negotiation.cc:461] Received NEGOTIATE request from client
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.619271 (+    65us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.619342 (+    71us) server_negotiation.cc:226] Negotiated authn=SASL
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.620285 (+   943us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.620810 (+   525us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.621925 (+  1115us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.622130 (+   205us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.622234 (+   104us) 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
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.624280 (+  2046us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.624283 (+     3us) server_negotiation.cc:881] Received SASL_INITIATE request from client
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.624286 (+     3us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.624314 (+    28us) server_negotiation.cc:922] calling sasl_server_start()
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.625379 (+  1065us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.625841 (+   462us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.625845 (+     4us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.625847 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.625912 (+    65us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626263 (+   351us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626266 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:39:53.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626267 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626410 (+   143us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626517 (+   107us) server_negotiation.cc:1035] Waiting for connection context
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626949 (+   432us) server_negotiation.cc:299] Negotiation successful
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.627059 (+   110us) negotiation.cc:327] Negotiation complete: OK
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":56}
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.627766 22736 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.617299 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.21.179.62:34079 (local address 127.21.179.3:54411)
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.617786 (+   487us) negotiation.cc:107] Waiting for socket to connect
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.617834 (+    48us) client_negotiation.cc:174] Beginning negotiation
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.619008 (+  1174us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.619481 (+   473us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.619486 (+     5us) client_negotiation.cc:394] Received NEGOTIATE response from server
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.619776 (+   290us) client_negotiation.cc:189] Negotiated authn=SASL
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.620137 (+   361us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.620148 (+    11us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.620934 (+   786us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.620937 (+     3us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:39:53.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.621787 (+   850us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.621812 (+    25us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.622264 (+   452us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.622268 (+     4us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.622430 (+   162us) 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
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.622923 (+   493us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.622936 (+    13us) client_negotiation.cc:656] calling sasl_client_start()
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.624093 (+  1157us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.625506 (+  1413us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.625511 (+     5us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.625521 (+    10us) client_negotiation.cc:760] calling sasl_client_step()
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.625727 (+   206us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626015 (+   288us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626018 (+     3us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626020 (+     2us) client_negotiation.cc:760] calling sasl_client_step()
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626145 (+   125us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626525 (+   380us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626532 (+     7us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626713 (+   181us) client_negotiation.cc:769] Sending connection context
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.626904 (+   191us) client_negotiation.cc:240] Negotiation successful
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 06:39:53.627097 (+   193us) negotiation.cc:327] Negotiation complete: OK
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":291,"thread_start_us":140,"threads_started":1}
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.628803 22734 heartbeater.cc:347] Connected to a master server at 127.21.179.62:34079
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.628983 22734 heartbeater.cc:464] Registering TS with master...
06:39:53.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.629354 22734 heartbeater.cc:511] Master 127.21.179.62:34079 requested a full tablet report, sending...
06:39:53.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.630268 22275 ts_manager.cc:194] Registered new tserver with Master: 737ad36a4215437abb6b7303741968c1 (127.21.179.3:41603)
06:39:53.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.630822 22275 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.21.179.3@KRBTEST.COM'} at 127.21.179.3:54411
06:39:53.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.631271 22220 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
06:39:53.632 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
06:39:53.633 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

06:39:53.641 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

06:39:53.642 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

06:39:53.649 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.21.179.62"
      port: 34079
    }
    bound_http_address {
      host: "127.21.179.62"
      port: 44319
    }
  }
}

06:39:53.653 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

06:39:53.655 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.21.179.1"
      port: 36559
    }
    bound_http_address {
      host: "127.21.179.1"
      port: 46265
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.21.179.2"
      port: 38625
    }
    bound_http_address {
      host: "127.21.179.2"
      port: 41909
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.21.179.3"
      port: 41603
    }
    bound_http_address {
      host: "127.21.179.3"
      port: 35539
    }
  }
}

06:39:53.656 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
06:39:53.870 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskbdSJOz/test-tmp/mini-kudu-cluster5983482904299651327/krb5kdc/krb5cc
06:39:53.892 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
06:39:53.903 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
06:39:53.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.905969 22220 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu with pid 22337
06:39:53.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.912101 22259 connection.cc:535] server connection from 127.21.179.1:54865 recv error: Network error: failed to read from TLS socket (remote: 127.21.179.1:54865): Connection reset by peer (error 104)
06:39:53.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.912235 22220 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu with pid 22471
06:39:53.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.917397 22260 connection.cc:535] server connection from 127.21.179.2:43171 recv error: Network error: failed to read from TLS socket (remote: 127.21.179.2:43171): Connection reset by peer (error 104)
06:39:53.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.917637 22220 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu with pid 22605
06:39:53.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.923496 22262 connection.cc:535] server connection from 127.21.179.3:54411 recv error: Network error: failed to read from TLS socket (remote: 127.21.179.3:54411): Connection reset by peer (error 104)
06:39:53.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.923692 22220 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskbdSJOz/build/debug/bin/kudu with pid 22243
06:39:53.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.929013 22228 connection.cc:535] client connection to 127.21.179.62:34079 recv error: Network error: failed to read from TLS socket (remote: 127.21.179.62:34079): Connection reset by peer (error 104)
06:39:53.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T06:39:53Z chronyd exiting

Time: 3.207

OK (1 test)

