JUnit version 4.13.2
.14:00:06.042 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1779112806033
14:00:06.114 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
14:00:06.181 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
14:00:06.195 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskcf9q1j/test-tmp
14:00:06.202 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/asan/bin
14:00:06.205 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskcf9q1j/java/build/dist-test/../../../build/asan/bin/kudu, test, mini_cluster, --serialization=pb]
14:00:06.444 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

14:00:06.676 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:00:06.678 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

14:00:06.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:06.681226 15487 mini_oidc.cc:150] Starting JWKS server
14:00:06.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:06.683732 15487 webserver.cc:533] Webserver started at http://127.0.0.1:38279/ using document root <none> and password file <none>
14:00:06.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:06.684019 15487 mini_oidc.cc:186] Starting OIDC Discovery server
14:00:06.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:06.685245 15487 webserver.cc:533] Webserver started at http://127.0.0.1:41415/ using document root <none> and password file <none>
14:00:06.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:00:06Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
14:00:06.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:00:06Z Disabled control of system clock
14:00:06.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:06.715376 15487 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:06.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:06.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/wal
14:00:06.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/data
14:00:06.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:00:06.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:00:06.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:00:06.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:06.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:06.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:06.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/logs
14:00:06.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/data/info.pb
14:00:06.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:06.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:00:06.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:00:06.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:00:06.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:00:06.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:06.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:06.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:06.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:00:06.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:00:06.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:00:06.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:00:06.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.254:41811
14:00:06.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.254
14:00:06.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:06.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:06.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:06.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:06.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:00:06.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:00:06.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:06.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:00:06.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38279/jwks.json with env {}
14:00:07.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.069072 15498 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:00:07.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.069504 15498 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:00:07.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.069622 15498 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:00:07.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.079113 15498 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:00:07.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.079286 15498 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:00:07.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.079372 15498 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:00:07.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.079430 15498 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:00:07.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.079504 15498 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:00:07.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.079555 15498 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:38279/jwks.json
14:00:07.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.091487 15498 master_runner.cc:387] Master server non-default flags:
14:00:07.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:07.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:07.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:07.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:00:07.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/data
14:00:07.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/wal
14:00:07.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:00:07.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:07.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:07.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:07.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:00:07.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.254:41811
14:00:07.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:00:07.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:00:07.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:00:07.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38279/jwks.json
14:00:07.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:07.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:07.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/data/info.pb
14:00:07.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.254
14:00:07.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:07.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:00:07.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:07.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:00:07.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:00:07.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:07.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/logs
14:00:07.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:07.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:00:07.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:00:07.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:00:07.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:00:07.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:00:07.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:00:07.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:23 UTC on bdcb31816ec0
14:00:07.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11958
14:00:07.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
14:00:07.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.094012 15498 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:00:07.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.097357 15498 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:00:07.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.110210 15504 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
14:00:07.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.110302 15506 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
14:00:07.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.110210 15503 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
14:00:07.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.110806 15498 server_base.cc:1061] running on GCE node
14:00:07.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.111828 15498 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:00:07.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.113787 15498 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:00:07.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.115093 15498 hybrid_clock.cc:648] HybridClock initialized: now 1779112807115025 us; error 69 us; skew 500 ppm
14:00:07.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.115654 15498 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:00:07.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.118453 15498 webserver.cc:533] Webserver started at http://127.15.31.254:43085/ using document root <none> and password file <none>
14:00:07.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.119488 15498 fs_manager.cc:362] Metadata directory not provided
14:00:07.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.119660 15498 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:00:07.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.120141 15498 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:00:07.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.122982 15498 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/data/instance:
14:00:07.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cc3197401a2a4720b3af524582d7825e"
14:00:07.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:07 on dist-test-slave-bmhl"
14:00:07.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.124075 15498 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/wal/instance:
14:00:07.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cc3197401a2a4720b3af524582d7825e"
14:00:07.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:07 on dist-test-slave-bmhl"
14:00:07.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.131587 15498 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.005s	sys 0.005s
14:00:07.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.136039 15512 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:00:07.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.137835 15498 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.002s
14:00:07.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.138010 15498 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/data,/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/wal
14:00:07.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cc3197401a2a4720b3af524582d7825e"
14:00:07.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:07 on dist-test-slave-bmhl"
14:00:07.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.138190 15498 fs_report.cc:389] FS layout report
14:00:07.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:00:07.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/wal
14:00:07.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/wal
14:00:07.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/data/data
14:00:07.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:00:07.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:00:07.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:00:07.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:00:07.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:00:07.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:00:07.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:00:07.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:00:07.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:00:07.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:00:07.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:00:07.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.161553 15498 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:00:07.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.162550 15498 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:00:07.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.162806 15498 kserver.cc:163] Server-wide thread pool size limit: 3276
14:00:07.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.186146 15498 rpc_server.cc:307] RPC server started. Bound to: 127.15.31.254:41811
14:00:07.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.186178 15563 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.31.254:41811 every 8 connection(s)
14:00:07.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.188091 15498 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/data/info.pb
14:00:07.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.193320 15564 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:00:07.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.198830 15487 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu as pid 15498
14:00:07.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.199224 15487 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-0/wal/instance
14:00:07.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.200702 15564 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } has no permanent_uuid. Determining permanent_uuid...
14:00:07.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.202329 15487 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:07.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:07.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/wal
14:00:07.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/data
14:00:07.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:00:07.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:00:07.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:00:07.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:07.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:07.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:07.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/logs
14:00:07.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/data/info.pb
14:00:07.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:07.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:00:07.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:00:07.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:00:07.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:00:07.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:07.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:07.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:07.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:00:07.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:00:07.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:00:07.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:00:07.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.253:33593
14:00:07.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.253
14:00:07.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:07.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:07.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:07.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:07.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:00:07.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:00:07.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:07.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:00:07.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38279/jwks.json with env {}
14:00:07.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.232539 15564 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } has no permanent_uuid. Determining permanent_uuid...
14:00:07.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.233947 15515 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.15.31.253:33593: connect: Connection refused (error 111)
14:00:07.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.235752 15564 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.253:33593: Network error: Client connection negotiation failed: client connection to 127.15.31.253:33593: connect: Connection refused (error 111)
14:00:07.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.285190 15564 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } attempt: 1
14:00:07.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.287726 15564 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.253:33593: Network error: Client connection negotiation failed: client connection to 127.15.31.253:33593: connect: Connection refused (error 111)
14:00:07.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.356066 15564 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } attempt: 2
14:00:07.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.358400 15564 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.253:33593: Network error: Client connection negotiation failed: client connection to 127.15.31.253:33593: connect: Connection refused (error 111)
14:00:07.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.449729 15564 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } attempt: 3
14:00:07.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.452057 15564 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.253:33593: Network error: Client connection negotiation failed: client connection to 127.15.31.253:33593: connect: Connection refused (error 111)
14:00:07.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.575860 15568 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:00:07.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.576210 15568 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:00:07.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.576288 15568 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:00:07.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.585263 15568 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:00:07.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.585369 15568 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:00:07.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.585424 15568 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:00:07.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.585464 15568 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:00:07.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.585517 15568 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:00:07.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.585551 15568 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:38279/jwks.json
14:00:07.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.595371 15564 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } attempt: 4
14:00:07.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.597677 15564 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.253:33593: Network error: Client connection negotiation failed: client connection to 127.15.31.253:33593: connect: Connection refused (error 111)
14:00:07.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.598259 15568 master_runner.cc:387] Master server non-default flags:
14:00:07.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:07.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:07.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:07.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:00:07.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/data
14:00:07.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/wal
14:00:07.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:00:07.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:07.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:07.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:07.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:00:07.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.253:33593
14:00:07.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:00:07.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:00:07.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:00:07.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38279/jwks.json
14:00:07.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:07.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:07.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/data/info.pb
14:00:07.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.253
14:00:07.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:07.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:00:07.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:07.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:00:07.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:00:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/logs
14:00:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:00:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:00:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:00:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:00:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:00:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:00:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:23 UTC on bdcb31816ec0
14:00:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11958
14:00:07.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
14:00:07.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.600559 15568 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:00:07.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.603127 15568 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:00:07.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.614060 15574 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
14:00:07.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.616878 15575 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
14:00:07.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.619571 15577 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
14:00:07.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.620894 15568 server_base.cc:1061] running on GCE node
14:00:07.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.622085 15568 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:00:07.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.624012 15568 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:00:07.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.625262 15568 hybrid_clock.cc:648] HybridClock initialized: now 1779112807625209 us; error 52 us; skew 500 ppm
14:00:07.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.625756 15568 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:00:07.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.628283 15568 webserver.cc:533] Webserver started at http://127.15.31.253:44059/ using document root <none> and password file <none>
14:00:07.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.629251 15568 fs_manager.cc:362] Metadata directory not provided
14:00:07.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.629415 15568 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:00:07.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.629892 15568 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:00:07.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.632543 15568 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/data/instance:
14:00:07.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9881a12599b0456888a13c7ed09b5fea"
14:00:07.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:07 on dist-test-slave-bmhl"
14:00:07.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.634369 15568 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/wal/instance:
14:00:07.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9881a12599b0456888a13c7ed09b5fea"
14:00:07.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:07 on dist-test-slave-bmhl"
14:00:07.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.640427 15568 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.005s	sys 0.000s
14:00:07.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.645047 15583 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:00:07.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.646713 15568 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.000s
14:00:07.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.646955 15568 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/data,/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/wal
14:00:07.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9881a12599b0456888a13c7ed09b5fea"
14:00:07.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:07 on dist-test-slave-bmhl"
14:00:07.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.647215 15568 fs_report.cc:389] FS layout report
14:00:07.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:00:07.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/wal
14:00:07.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/wal
14:00:07.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/data/data
14:00:07.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:00:07.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:00:07.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:00:07.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:00:07.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:00:07.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:00:07.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:00:07.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:00:07.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:00:07.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:00:07.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:00:07.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.673157 15568 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:00:07.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.674346 15568 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:00:07.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.674710 15568 kserver.cc:163] Server-wide thread pool size limit: 3276
14:00:07.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.697562 15568 rpc_server.cc:307] RPC server started. Bound to: 127.15.31.253:33593
14:00:07.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.697580 15634 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.31.253:33593 every 8 connection(s)
14:00:07.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.699437 15568 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/data/info.pb
14:00:07.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.704919 15635 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:00:07.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.707111 15487 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu as pid 15568
14:00:07.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.707343 15487 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-1/wal/instance
14:00:07.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.708878 15487 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:07.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:07.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/wal
14:00:07.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/data
14:00:07.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:00:07.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:00:07.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:00:07.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:07.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:07.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:07.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/logs
14:00:07.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/data/info.pb
14:00:07.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:07.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:00:07.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:00:07.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:00:07.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:00:07.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:07.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:07.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:07.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:00:07.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:00:07.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:00:07.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:00:07.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.252:34123
14:00:07.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.252
14:00:07.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:07.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:07.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:07.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:07.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:00:07.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:00:07.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:07.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:00:07.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38279/jwks.json with env {}
14:00:07.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.715492 15635 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } has no permanent_uuid. Determining permanent_uuid...
14:00:07.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.732682 15635 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } has no permanent_uuid. Determining permanent_uuid...
14:00:07.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.743922 15635 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } has no permanent_uuid. Determining permanent_uuid...
14:00:07.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.745465 15585 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.15.31.252:34123: connect: Connection refused (error 111)
14:00:07.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.747205 15635 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.252:34123: Network error: Client connection negotiation failed: client connection to 127.15.31.252:34123: connect: Connection refused (error 111)
14:00:07.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.796538 15635 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } attempt: 1
14:00:07.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.799126 15635 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.252:34123: Network error: Client connection negotiation failed: client connection to 127.15.31.252:34123: connect: Connection refused (error 111)
14:00:07.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.867447 15635 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } attempt: 2
14:00:07.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.869815 15635 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.252:34123: Network error: Client connection negotiation failed: client connection to 127.15.31.252:34123: connect: Connection refused (error 111)
14:00:07.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.896973 15564 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } attempt: 5
14:00:07.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.903615 15564 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } has no permanent_uuid. Determining permanent_uuid...
14:00:07.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.905694 15564 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.252:34123: Network error: Client connection negotiation failed: client connection to 127.15.31.252:34123: connect: Connection refused (error 111)
14:00:07.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.957026 15564 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } attempt: 1
14:00:07.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.959435 15564 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.252:34123: Network error: Client connection negotiation failed: client connection to 127.15.31.252:34123: connect: Connection refused (error 111)
14:00:07.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:07.961076 15635 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } attempt: 3
14:00:07.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:07.963248 15635 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.252:34123: Network error: Client connection negotiation failed: client connection to 127.15.31.252:34123: connect: Connection refused (error 111)
14:00:08.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.027715 15564 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } attempt: 2
14:00:08.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.030321 15564 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.252:34123: Network error: Client connection negotiation failed: client connection to 127.15.31.252:34123: connect: Connection refused (error 111)
14:00:08.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.084120 15637 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:00:08.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.084582 15637 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:00:08.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.084705 15637 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:00:08.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.094224 15637 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:00:08.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.094399 15637 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:00:08.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.094492 15637 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:00:08.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.094554 15637 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:00:08.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.094630 15637 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:00:08.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.094683 15637 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:38279/jwks.json
14:00:08.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.106570 15635 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } attempt: 4
14:00:08.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.106894 15637 master_runner.cc:387] Master server non-default flags:
14:00:08.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:08.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:08.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:08.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:00:08.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/data
14:00:08.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/wal
14:00:08.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:00:08.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:08.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:08.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:08.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:00:08.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.252:34123
14:00:08.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:00:08.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:00:08.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:00:08.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38279/jwks.json
14:00:08.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:08.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:08.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/data/info.pb
14:00:08.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.252
14:00:08.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:08.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:00:08.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:08.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:00:08.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:00:08.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:08.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/logs
14:00:08.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:08.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:00:08.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:00:08.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:00:08.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:00:08.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:00:08.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:00:08.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:23 UTC on bdcb31816ec0
14:00:08.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11958
14:00:08.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
14:00:08.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.108752 15635 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.252:34123: Network error: Client connection negotiation failed: client connection to 127.15.31.252:34123: connect: Connection refused (error 111)
14:00:08.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.109301 15637 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:00:08.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.112066 15637 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:00:08.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.121893 15645 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
14:00:08.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.122109 15646 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
14:00:08.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.123473 15648 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
14:00:08.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.123592 15637 server_base.cc:1061] running on GCE node
14:00:08.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.124388 15637 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:00:08.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.126291 15637 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:00:08.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.127542 15637 hybrid_clock.cc:648] HybridClock initialized: now 1779112808127478 us; error 64 us; skew 500 ppm
14:00:08.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.127910 15637 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:00:08.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.130671 15637 webserver.cc:533] Webserver started at http://127.15.31.252:37253/ using document root <none> and password file <none>
14:00:08.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.131433 15637 fs_manager.cc:362] Metadata directory not provided
14:00:08.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.131538 15637 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:00:08.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.131882 15637 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:00:08.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.134501 15637 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/data/instance:
14:00:08.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "95b033043aa647f4bf0c66c5c583af02"
14:00:08.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:08 on dist-test-slave-bmhl"
14:00:08.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.135295 15637 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/wal/instance:
14:00:08.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "95b033043aa647f4bf0c66c5c583af02"
14:00:08.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:08 on dist-test-slave-bmhl"
14:00:08.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.136610 15564 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } attempt: 3
14:00:08.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.138911 15564 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.31.252:34123: Network error: Client connection negotiation failed: client connection to 127.15.31.252:34123: connect: Connection refused (error 111)
14:00:08.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.142022 15637 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.003s	sys 0.005s
14:00:08.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.146201 15654 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:00:08.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.147831 15637 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.002s
14:00:08.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.148224 15637 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/data,/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/wal
14:00:08.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "95b033043aa647f4bf0c66c5c583af02"
14:00:08.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:08 on dist-test-slave-bmhl"
14:00:08.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.148480 15637 fs_report.cc:389] FS layout report
14:00:08.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:00:08.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/wal
14:00:08.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/wal
14:00:08.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/data/data
14:00:08.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:00:08.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:00:08.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:00:08.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:00:08.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:00:08.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:00:08.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:00:08.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:00:08.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:00:08.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:00:08.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:00:08.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.170145 15637 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:00:08.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.171336 15637 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:00:08.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.171723 15637 kserver.cc:163] Server-wide thread pool size limit: 3276
14:00:08.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.199201 15637 rpc_server.cc:307] RPC server started. Bound to: 127.15.31.252:34123
14:00:08.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.199220 15705 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.31.252:34123 every 8 connection(s)
14:00:08.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.200999 15637 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/data/info.pb
14:00:08.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.201267 15487 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu as pid 15637
14:00:08.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.201454 15487 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/master-2/wal/instance
14:00:08.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.205960 15706 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:00:08.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.213280 15706 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } has no permanent_uuid. Determining permanent_uuid...
14:00:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.228631 15706 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } has no permanent_uuid. Determining permanent_uuid...
14:00:08.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.236351 15706 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } has no permanent_uuid. Determining permanent_uuid...
14:00:08.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.247123 15706 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02: Bootstrap starting.
14:00:08.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.250691 15706 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02: Neither blocks nor log segments found. Creating new log.
14:00:08.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.251816 15706 log.cc:826] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02: Log is configured to *not* fsync() on all Append() calls
14:00:08.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.255403 15706 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02: No bootstrap required, opened a new log
14:00:08.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.261258 15706 raft_consensus.cc:359] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } }
14:00:08.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.261572 15706 raft_consensus.cc:385] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:00:08.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.261657 15706 raft_consensus.cc:740] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 95b033043aa647f4bf0c66c5c583af02, State: Initialized, Role: FOLLOWER
14:00:08.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.262459 15706 consensus_queue.cc:260] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [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: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } }
14:00:08.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.263545 15713 sys_catalog.cc:455] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } } }
14:00:08.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.263821 15713 sys_catalog.cc:458] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [sys.catalog]: This master's current role is: FOLLOWER
14:00:08.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.264635 15706 sys_catalog.cc:565] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [sys.catalog]: configured and running, proceeding with master startup.
14:00:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.275565 15724 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:00:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.275722 15724 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:00:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.273046 15637 master_runner.cc:187] Error getting master registration for 127.15.31.254:41811: OK, instance_id { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" instance_seqno: 1779112807179442 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:00:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.278314 15637 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:00:08.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.316164 15564 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } attempt: 4
14:00:08.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.327630 15564 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e: Bootstrap starting.
14:00:08.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.331750 15564 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e: Neither blocks nor log segments found. Creating new log.
14:00:08.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.332899 15564 log.cc:826] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e: Log is configured to *not* fsync() on all Append() calls
14:00:08.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.335525 15564 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e: No bootstrap required, opened a new log
14:00:08.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.340710 15564 raft_consensus.cc:359] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } }
14:00:08.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.341111 15564 raft_consensus.cc:385] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:00:08.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.341205 15564 raft_consensus.cc:740] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: cc3197401a2a4720b3af524582d7825e, State: Initialized, Role: FOLLOWER
14:00:08.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.342592 15564 consensus_queue.cc:260] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [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: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } }
14:00:08.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.343802 15727 sys_catalog.cc:455] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } } }
14:00:08.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.344518 15727 sys_catalog.cc:458] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [sys.catalog]: This master's current role is: FOLLOWER
14:00:08.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.346025 15564 sys_catalog.cc:565] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [sys.catalog]: configured and running, proceeding with master startup.
14:00:08.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.358489 15738 catalog_manager.cc:1593] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:00:08.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.359304 15738 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:00:08.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.357944 15498 master_runner.cc:187] Error getting master registration for 127.15.31.253:33593: OK, instance_id { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" instance_seqno: 1779112807691132 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:00:08.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.368884 15498 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:00:08.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.402788 15727 raft_consensus.cc:493] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:00:08.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.403115 15727 raft_consensus.cc:515] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } }
14:00:08.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.405094 15727 leader_election.cc:290] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 9881a12599b0456888a13c7ed09b5fea (127.15.31.253:33593), 95b033043aa647f4bf0c66c5c583af02 (127.15.31.252:34123)
14:00:08.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.406606 15681 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "cc3197401a2a4720b3af524582d7825e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "95b033043aa647f4bf0c66c5c583af02" is_pre_election: true
14:00:08.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.407236 15681 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate cc3197401a2a4720b3af524582d7825e in term 0.
14:00:08.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.408008 15514 leader_election.cc:304] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 95b033043aa647f4bf0c66c5c583af02, cc3197401a2a4720b3af524582d7825e; no voters: 
14:00:08.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.408502 15727 raft_consensus.cc:2804] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [term 0 FOLLOWER]: Leader pre-election won for term 1
14:00:08.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.408653 15727 raft_consensus.cc:493] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:00:08.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.408746 15727 raft_consensus.cc:3060] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [term 0 FOLLOWER]: Advancing to term 1
14:00:08.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.409621 15635 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } attempt: 5
14:00:08.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.411957 15727 raft_consensus.cc:515] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } }
14:00:08.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.414685 15681 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "cc3197401a2a4720b3af524582d7825e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "95b033043aa647f4bf0c66c5c583af02"
14:00:08.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.414940 15681 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [term 0 FOLLOWER]: Advancing to term 1
14:00:08.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.416481 15518 tablet.cc:2404] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:00:08.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.418582 15681 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate cc3197401a2a4720b3af524582d7825e in term 1.
14:00:08.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.419111 15514 leader_election.cc:304] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 95b033043aa647f4bf0c66c5c583af02, cc3197401a2a4720b3af524582d7825e; no voters: 
14:00:08.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.421231 15727 leader_election.cc:290] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [CANDIDATE]: Term 1 election: Requested vote from peers 9881a12599b0456888a13c7ed09b5fea (127.15.31.253:33593), 95b033043aa647f4bf0c66c5c583af02 (127.15.31.252:34123)
14:00:08.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.421506 15727 raft_consensus.cc:2804] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [term 1 FOLLOWER]: Leader election won for term 1
14:00:08.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.421646 15727 raft_consensus.cc:697] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [term 1 LEADER]: Becoming Leader. State: Replica: cc3197401a2a4720b3af524582d7825e, State: Running, Role: LEADER
14:00:08.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.422231 15727 consensus_queue.cc:237] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [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: 2, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } }
14:00:08.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:08.424233 15660 tablet.cc:2404] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:00:08.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.445047 15635 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea: Bootstrap starting.
14:00:08.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.468346 15635 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea: Neither blocks nor log segments found. Creating new log.
14:00:08.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.470077 15635 log.cc:826] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea: Log is configured to *not* fsync() on all Append() calls
14:00:08.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.475080 15740 sys_catalog.cc:455] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [sys.catalog]: SysCatalogTable state changed. Reason: New leader cc3197401a2a4720b3af524582d7825e. Latest consensus state: current_term: 1 leader_uuid: "cc3197401a2a4720b3af524582d7825e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } } }
14:00:08.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.475421 15740 sys_catalog.cc:458] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [sys.catalog]: This master's current role is: LEADER
14:00:08.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.483258 15743 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
14:00:08.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.486451 15743 catalog_manager.cc:1519] Initializing Kudu cluster ID...
14:00:08.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.487174 15635 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea: No bootstrap required, opened a new log
14:00:08.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.497006 15635 raft_consensus.cc:359] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } }
14:00:08.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.499099 15635 raft_consensus.cc:385] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:00:08.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.499615 15635 raft_consensus.cc:740] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 9881a12599b0456888a13c7ed09b5fea, State: Initialized, Role: FOLLOWER
14:00:08.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.500907 15635 consensus_queue.cc:260] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [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: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } }
14:00:08.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.511675 15744 sys_catalog.cc:455] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } } }
14:00:08.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.513454 15635 sys_catalog.cc:565] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [sys.catalog]: configured and running, proceeding with master startup.
14:00:08.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.513496 15609 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "cc3197401a2a4720b3af524582d7825e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "9881a12599b0456888a13c7ed09b5fea"
14:00:08.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.514637 15609 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [term 0 FOLLOWER]: Advancing to term 1
14:00:08.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.515959 15744 sys_catalog.cc:458] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [sys.catalog]: This master's current role is: FOLLOWER
14:00:08.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.513844 15610 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "cc3197401a2a4720b3af524582d7825e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "9881a12599b0456888a13c7ed09b5fea" is_pre_election: true
14:00:08.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.518036 15609 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate cc3197401a2a4720b3af524582d7825e in term 1.
14:00:08.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.521533 15680 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [term 1 FOLLOWER]: Refusing update from remote peer cc3197401a2a4720b3af524582d7825e: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:00:08.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.522647 15740 consensus_queue.cc:1048] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [LEADER]: Connected to new peer: Peer: permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:00:08.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.529708 15609 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [term 1 FOLLOWER]: Refusing update from remote peer cc3197401a2a4720b3af524582d7825e: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:00:08.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.530905 15740 consensus_queue.cc:1048] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [LEADER]: Connected to new peer: Peer: permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:00:08.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.552175 15744 sys_catalog.cc:455] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [sys.catalog]: SysCatalogTable state changed. Reason: New leader cc3197401a2a4720b3af524582d7825e. Latest consensus state: current_term: 1 leader_uuid: "cc3197401a2a4720b3af524582d7825e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } } }
14:00:08.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.552479 15744 sys_catalog.cc:458] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [sys.catalog]: This master's current role is: FOLLOWER
14:00:08.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.560142 15748 mvcc.cc:204] Tried to move back new op lower bound from 7287246063692693504 to 7287246063321796608. Current Snapshot: MvccSnapshot[applied={T|T < 7287246063692693504}]
14:00:08.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.561344 15740 sys_catalog.cc:455] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "cc3197401a2a4720b3af524582d7825e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } } }
14:00:08.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.561597 15740 sys_catalog.cc:458] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [sys.catalog]: This master's current role is: LEADER
14:00:08.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.562897 15744 sys_catalog.cc:455] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "cc3197401a2a4720b3af524582d7825e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } } }
14:00:08.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.563197 15744 sys_catalog.cc:458] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea [sys.catalog]: This master's current role is: FOLLOWER
14:00:08.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.566900 15743 catalog_manager.cc:1382] Generated new cluster ID: b428812c618e40eeabc5fe1a82cd5e50
14:00:08.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.567055 15743 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
14:00:08.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.569954 15713 sys_catalog.cc:455] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [sys.catalog]: SysCatalogTable state changed. Reason: New leader cc3197401a2a4720b3af524582d7825e. Latest consensus state: current_term: 1 leader_uuid: "cc3197401a2a4720b3af524582d7825e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } } }
14:00:08.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.570286 15713 sys_catalog.cc:458] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [sys.catalog]: This master's current role is: FOLLOWER
14:00:08.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.574352 15727 sys_catalog.cc:455] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "cc3197401a2a4720b3af524582d7825e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } } }
14:00:08.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.574666 15727 sys_catalog.cc:458] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e [sys.catalog]: This master's current role is: LEADER
14:00:08.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.589720 15743 catalog_manager.cc:1405] Generated new certificate authority record
14:00:08.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.591728 15743 catalog_manager.cc:1539] Loading token signing keys...
14:00:08.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.597362 15713 sys_catalog.cc:455] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "cc3197401a2a4720b3af524582d7825e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cc3197401a2a4720b3af524582d7825e" member_type: VOTER last_known_addr { host: "127.15.31.254" port: 41811 } } peers { permanent_uuid: "9881a12599b0456888a13c7ed09b5fea" member_type: VOTER last_known_addr { host: "127.15.31.253" port: 33593 } } peers { permanent_uuid: "95b033043aa647f4bf0c66c5c583af02" member_type: VOTER last_known_addr { host: "127.15.31.252" port: 34123 } } }
14:00:08.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.597620 15713 sys_catalog.cc:458] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02 [sys.catalog]: This master's current role is: FOLLOWER
14:00:08.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.623988 15743 catalog_manager.cc:6069] T 00000000000000000000000000000000 P cc3197401a2a4720b3af524582d7825e: Generated new TSK 0
14:00:08.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.626513 15743 catalog_manager.cc:1549] Initializing in-progress tserver states...
14:00:08.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.654917 15487 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:08.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:08.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/wal
14:00:08.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/data
14:00:08.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:00:08.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:00:08.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:00:08.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:08.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:08.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:08.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/logs
14:00:08.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/data/info.pb
14:00:08.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.193:0
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.31.193
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.193
14:00:08.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:08.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:08.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:08.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:08.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:08.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:00:08.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.664307 15764 catalog_manager.cc:1294] Loaded cluster ID: b428812c618e40eeabc5fe1a82cd5e50
14:00:08.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.664858 15764 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea: loading cluster ID for follower catalog manager: success
14:00:08.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.669806 15764 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea: acquiring CA information for follower catalog manager: success
14:00:08.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:08.674794 15764 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 9881a12599b0456888a13c7ed09b5fea: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:00:09.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.126118 15766 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:00:09.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.126488 15766 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:00:09.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.126613 15766 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:00:09.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.136945 15766 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:00:09.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.137200 15766 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.15.31.193
14:00:09.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.148260 15766 tablet_server_runner.cc:78] Tablet server non-default flags:
14:00:09.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:09.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:09.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:09.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:00:09.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/data
14:00:09.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/wal
14:00:09.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:09.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:09.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.193:0
14:00:09.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:00:09.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:09.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:09.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/data/info.pb
14:00:09.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.193
14:00:09.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:09.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:09.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:00:09.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:09.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:00:09.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:00:09.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:09.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.31.193
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/logs
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:23 UTC on bdcb31816ec0
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11958
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
14:00:09.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.150676 15766 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:00:09.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.153277 15766 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:00:09.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.166831 15772 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
14:00:09.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.169274 15771 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
14:00:09.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.174340 15774 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
14:00:09.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.175124 15766 server_base.cc:1061] running on GCE node
14:00:09.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.175904 15766 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:00:09.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.177291 15766 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:00:09.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.178791 15766 hybrid_clock.cc:648] HybridClock initialized: now 1779112809178669 us; error 114 us; skew 500 ppm
14:00:09.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.179255 15766 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:00:09.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.183379 15766 webserver.cc:533] Webserver started at http://127.15.31.193:43897/ using document root <none> and password file <none>
14:00:09.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.184391 15766 fs_manager.cc:362] Metadata directory not provided
14:00:09.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.184553 15766 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:00:09.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.185055 15766 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:00:09.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.188033 15766 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/data/instance:
14:00:09.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "06df44aeece845c68e0176a79a137502"
14:00:09.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:09 on dist-test-slave-bmhl"
14:00:09.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.189113 15766 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/wal/instance:
14:00:09.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "06df44aeece845c68e0176a79a137502"
14:00:09.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:09 on dist-test-slave-bmhl"
14:00:09.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.198311 15766 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.002s	sys 0.005s
14:00:09.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.214541 15780 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:00:09.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.217082 15766 fs_manager.cc:730] Time spent opening block manager: real 0.016s	user 0.002s	sys 0.012s
14:00:09.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.217334 15766 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/data,/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/wal
14:00:09.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "06df44aeece845c68e0176a79a137502"
14:00:09.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:09 on dist-test-slave-bmhl"
14:00:09.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.217623 15766 fs_report.cc:389] FS layout report
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/wal
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/wal
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/data/data
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:00:09.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:00:09.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.245591 15766 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:00:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.246863 15766 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:00:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.247222 15766 kserver.cc:163] Server-wide thread pool size limit: 3276
14:00:09.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.248629 15766 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:00:09.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.251071 15766 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:00:09.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.251219 15766 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:00:09.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.251348 15766 ts_tablet_manager.cc:616] Registered 0 tablets
14:00:09.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.251433 15766 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:00:09.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.278748 15724 catalog_manager.cc:1294] Loaded cluster ID: b428812c618e40eeabc5fe1a82cd5e50
14:00:09.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.278905 15724 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02: loading cluster ID for follower catalog manager: success
14:00:09.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.284324 15724 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02: acquiring CA information for follower catalog manager: success
14:00:09.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.288893 15724 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 95b033043aa647f4bf0c66c5c583af02: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:00:09.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.301761 15766 rpc_server.cc:307] RPC server started. Bound to: 127.15.31.193:39791
14:00:09.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.301883 15892 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.31.193:39791 every 8 connection(s)
14:00:09.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.303305 15766 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/data/info.pb
14:00:09.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.305706 15487 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu as pid 15766
14:00:09.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.305972 15487 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-0/wal/instance
14:00:09.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.315201 15487 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:09.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:09.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/wal
14:00:09.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/data
14:00:09.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:00:09.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:00:09.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:00:09.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:09.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:09.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:09.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/logs
14:00:09.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/data/info.pb
14:00:09.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:09.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:00:09.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:00:09.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:00:09.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:00:09.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:09.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:09.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:09.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:00:09.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:00:09.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.194:0
14:00:09.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.31.194
14:00:09.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.194
14:00:09.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:09.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:09.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:09.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:09.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:09.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:00:09.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.333669 15894 heartbeater.cc:344] Connected to a master server at 127.15.31.254:41811
14:00:09.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.334242 15894 heartbeater.cc:461] Registering TS with master...
14:00:09.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.335254 15894 heartbeater.cc:507] Master 127.15.31.254:41811 requested a full tablet report, sending...
14:00:09.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.336493 15895 heartbeater.cc:344] Connected to a master server at 127.15.31.253:33593
14:00:09.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.336643 15895 heartbeater.cc:461] Registering TS with master...
14:00:09.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.337119 15895 heartbeater.cc:507] Master 127.15.31.253:33593 requested a full tablet report, sending...
14:00:09.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.337837 15529 ts_manager.cc:194] Registered new tserver with Master: 06df44aeece845c68e0176a79a137502 (127.15.31.193:39791)
14:00:09.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.340595 15529 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.15.31.193:45775
14:00:09.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.341357 15893 heartbeater.cc:344] Connected to a master server at 127.15.31.252:34123
14:00:09.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.341528 15893 heartbeater.cc:461] Registering TS with master...
14:00:09.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.342283 15893 heartbeater.cc:507] Master 127.15.31.252:34123 requested a full tablet report, sending...
14:00:09.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.342286 15600 ts_manager.cc:194] Registered new tserver with Master: 06df44aeece845c68e0176a79a137502 (127.15.31.193:39791)
14:00:09.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.344261 15671 ts_manager.cc:194] Registered new tserver with Master: 06df44aeece845c68e0176a79a137502 (127.15.31.193:39791)
14:00:09.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.687908 15903 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:00:09.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.688287 15903 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:00:09.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.688361 15903 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:00:09.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.697877 15903 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:00:09.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.698172 15903 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.15.31.194
14:00:09.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.710147 15903 tablet_server_runner.cc:78] Tablet server non-default flags:
14:00:09.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:09.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/data
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/wal
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.194:0
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/data/info.pb
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.194
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:09.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.31.194
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/logs
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:00:09.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:00:09.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:23 UTC on bdcb31816ec0
14:00:09.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11958
14:00:09.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
14:00:09.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.712563 15903 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:00:09.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.714695 15903 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:00:09.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.725956 15908 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
14:00:09.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.725987 15909 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
14:00:09.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:09.726539 15911 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
14:00:09.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.728039 15903 server_base.cc:1061] running on GCE node
14:00:09.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.728767 15903 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:00:09.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.730051 15903 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:00:09.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.731307 15903 hybrid_clock.cc:648] HybridClock initialized: now 1779112809731248 us; error 52 us; skew 500 ppm
14:00:09.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.731725 15903 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:00:09.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.734278 15903 webserver.cc:533] Webserver started at http://127.15.31.194:43863/ using document root <none> and password file <none>
14:00:09.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.735193 15903 fs_manager.cc:362] Metadata directory not provided
14:00:09.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.735334 15903 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:00:09.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.735754 15903 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:00:09.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.738368 15903 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/data/instance:
14:00:09.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ac1d330ec4324400baf7bc6ad669d481"
14:00:09.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:09 on dist-test-slave-bmhl"
14:00:09.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.739332 15903 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/wal/instance:
14:00:09.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ac1d330ec4324400baf7bc6ad669d481"
14:00:09.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:09 on dist-test-slave-bmhl"
14:00:09.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.746491 15903 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.002s	sys 0.005s
14:00:09.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.754196 15917 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:00:09.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.756564 15903 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.005s	sys 0.000s
14:00:09.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.756901 15903 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/data,/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/wal
14:00:09.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ac1d330ec4324400baf7bc6ad669d481"
14:00:09.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:09 on dist-test-slave-bmhl"
14:00:09.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.757143 15903 fs_report.cc:389] FS layout report
14:00:09.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/wal
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/wal
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/data/data
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:00:09.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:00:09.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:00:09.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:00:09.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.783466 15903 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:00:09.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.784884 15903 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:00:09.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.785599 15903 kserver.cc:163] Server-wide thread pool size limit: 3276
14:00:09.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.787089 15903 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:00:09.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.789929 15903 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:00:09.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.790076 15903 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:00:09.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.790199 15903 ts_tablet_manager.cc:616] Registered 0 tablets
14:00:09.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.790282 15903 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:00:09.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.829864 15903 rpc_server.cc:307] RPC server started. Bound to: 127.15.31.194:38327
14:00:09.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.829993 16029 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.31.194:38327 every 8 connection(s)
14:00:09.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.831530 15903 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/data/info.pb
14:00:09.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.836012 15487 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu as pid 15903
14:00:09.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.836207 15487 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-1/wal/instance
14:00:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.841156 15487 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu
14:00:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/wal
14:00:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/data
14:00:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:00:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:00:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:00:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/logs
14:00:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/data/info.pb
14:00:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:00:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:00:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:00:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:00:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.195:0
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.31.195
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.195
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:00:09.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.868501 16032 heartbeater.cc:344] Connected to a master server at 127.15.31.253:33593
14:00:09.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.868675 16031 heartbeater.cc:344] Connected to a master server at 127.15.31.254:41811
14:00:09.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.868966 16031 heartbeater.cc:461] Registering TS with master...
14:00:09.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.868973 16032 heartbeater.cc:461] Registering TS with master...
14:00:09.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.868557 16030 heartbeater.cc:344] Connected to a master server at 127.15.31.252:34123
14:00:09.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.869592 16030 heartbeater.cc:461] Registering TS with master...
14:00:09.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.870420 16030 heartbeater.cc:507] Master 127.15.31.252:34123 requested a full tablet report, sending...
14:00:09.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.870455 16032 heartbeater.cc:507] Master 127.15.31.253:33593 requested a full tablet report, sending...
14:00:09.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.871378 16031 heartbeater.cc:507] Master 127.15.31.254:41811 requested a full tablet report, sending...
14:00:09.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.872411 15529 ts_manager.cc:194] Registered new tserver with Master: ac1d330ec4324400baf7bc6ad669d481 (127.15.31.194:38327)
14:00:09.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.872503 15600 ts_manager.cc:194] Registered new tserver with Master: ac1d330ec4324400baf7bc6ad669d481 (127.15.31.194:38327)
14:00:09.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.872524 15671 ts_manager.cc:194] Registered new tserver with Master: ac1d330ec4324400baf7bc6ad669d481 (127.15.31.194:38327)
14:00:09.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:09.873584 15529 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.15.31.194:44119
14:00:10.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:10.216552 16040 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:00:10.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:10.216900 16040 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:00:10.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:10.216974 16040 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:00:10.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:10.225852 16040 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:00:10.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:10.226040 16040 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.15.31.195
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.236969 16040 tablet_server_runner.cc:78] Tablet server non-default flags:
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.31.212:33739
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/data
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/wal
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.31.195:0
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/data/info.pb
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.31.195
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.31.254:41811,127.15.31.253:33593,127.15.31.252:34123
14:00:10.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.31.195
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/logs
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:00:10.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:00:10.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:23 UTC on bdcb31816ec0
14:00:10.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11958
14:00:10.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
14:00:10.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.238631 16040 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:00:10.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.240952 16040 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:00:10.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:10.251780 16048 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
14:00:10.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:10.251874 16047 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
14:00:10.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.252710 16040 server_base.cc:1061] running on GCE node
14:00:10.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:10.251937 16050 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
14:00:10.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.253640 16040 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:00:10.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.255054 16040 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:00:10.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.256342 16040 hybrid_clock.cc:648] HybridClock initialized: now 1779112810256265 us; error 50 us; skew 500 ppm
14:00:10.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.256812 16040 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:00:10.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.259558 16040 webserver.cc:533] Webserver started at http://127.15.31.195:39839/ using document root <none> and password file <none>
14:00:10.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.260313 16040 fs_manager.cc:362] Metadata directory not provided
14:00:10.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.260416 16040 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:00:10.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.260705 16040 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:00:10.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.263489 16040 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/data/instance:
14:00:10.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eaf18f7693ec4269a3f51393203a3e32"
14:00:10.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:10 on dist-test-slave-bmhl"
14:00:10.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.264338 16040 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/wal/instance:
14:00:10.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eaf18f7693ec4269a3f51393203a3e32"
14:00:10.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:10 on dist-test-slave-bmhl"
14:00:10.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.270288 16040 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.007s	sys 0.001s
14:00:10.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.274037 16056 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:00:10.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.275667 16040 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.275821 16040 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/data,/tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/wal
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eaf18f7693ec4269a3f51393203a3e32"
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:00:10 on dist-test-slave-bmhl"
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.276052 16040 fs_report.cc:389] FS layout report
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/wal
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/wal
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/data/data
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:00:10.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:00:10.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.309209 16040 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:00:10.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.310067 16040 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:00:10.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.310299 16040 kserver.cc:163] Server-wide thread pool size limit: 3276
14:00:10.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.311278 16040 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:00:10.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.313067 16040 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:00:10.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.313165 16040 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:00:10.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.313246 16040 ts_tablet_manager.cc:616] Registered 0 tablets
14:00:10.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.313298 16040 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:00:10.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.344493 15894 heartbeater.cc:499] Master 127.15.31.254:41811 was elected leader, sending a full tablet report...
14:00:10.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.352490 16040 rpc_server.cc:307] RPC server started. Bound to: 127.15.31.195:46443
14:00:10.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.352632 16168 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.31.195:46443 every 8 connection(s)
14:00:10.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.353950 16040 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/data/info.pb
14:00:10.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.355567 15487 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu as pid 16040
14:00:10.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.355736 15487 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskcf9q1j/test-tmp/mini-kudu-cluster4110563241357514776/ts-2/wal/instance
14:00:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.375572 16169 heartbeater.cc:344] Connected to a master server at 127.15.31.252:34123
14:00:10.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.376047 16169 heartbeater.cc:461] Registering TS with master...
14:00:10.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.376971 16170 heartbeater.cc:344] Connected to a master server at 127.15.31.254:41811
14:00:10.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.377121 16170 heartbeater.cc:461] Registering TS with master...
14:00:10.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.377311 16169 heartbeater.cc:507] Master 127.15.31.252:34123 requested a full tablet report, sending...
14:00:10.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.377599 16170 heartbeater.cc:507] Master 127.15.31.254:41811 requested a full tablet report, sending...
14:00:10.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.378351 16171 heartbeater.cc:344] Connected to a master server at 127.15.31.253:33593
14:00:10.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.378499 16171 heartbeater.cc:461] Registering TS with master...
14:00:10.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.379032 16171 heartbeater.cc:507] Master 127.15.31.253:33593 requested a full tablet report, sending...
14:00:10.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.379374 15529 ts_manager.cc:194] Registered new tserver with Master: eaf18f7693ec4269a3f51393203a3e32 (127.15.31.195:46443)
14:00:10.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.379976 15671 ts_manager.cc:194] Registered new tserver with Master: eaf18f7693ec4269a3f51393203a3e32 (127.15.31.195:46443)
14:00:10.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.380452 15529 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.15.31.195:55745
14:00:10.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.381014 15600 ts_manager.cc:194] Registered new tserver with Master: eaf18f7693ec4269a3f51393203a3e32 (127.15.31.195:46443)
14:00:10.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.385468 15487 external_mini_cluster.cc:949] 3 TS(s) registered with all masters
14:00:10.387 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:00:10.388 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

14:00:10.398 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.15.31.254"
      port: 41811
    }
    bound_http_address {
      host: "127.15.31.254"
      port: 43085
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.15.31.253"
      port: 33593
    }
    bound_http_address {
      host: "127.15.31.253"
      port: 44059
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.15.31.252"
      port: 34123
    }
    bound_http_address {
      host: "127.15.31.252"
      port: 37253
    }
  }
}

14:00:10.401 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

14:00:10.403 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.15.31.193"
      port: 39791
    }
    bound_http_address {
      host: "127.15.31.193"
      port: 43897
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.15.31.194"
      port: 38327
    }
    bound_http_address {
      host: "127.15.31.194"
      port: 43863
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.15.31.195"
      port: 46443
    }
    bound_http_address {
      host: "127.15.31.195"
      port: 39839
    }
  }
}

14:00:10.404 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
14:00:10.569 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttemptAndReport(RetryRule.java:184)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:244)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
14:00:10.628 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
14:00:10.771 [DEBUG - Time-limited test] (Connection.java:748) [peer master-127.15.31.254:41811(127.15.31.254:41811)] connecting to peer
14:00:10.822 [DEBUG - Time-limited test] (Connection.java:748) [peer master-127.15.31.252:34123(127.15.31.252:34123)] connecting to peer
14:00:10.824 [DEBUG - Time-limited test] (Connection.java:748) [peer master-127.15.31.253:33593(127.15.31.253:33593)] connecting to peer
14:00:10.846 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.15.31.254:41811(127.15.31.254:41811)] Successfully connected to peer
14:00:10.848 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.15.31.252:34123(127.15.31.252:34123)] Successfully connected to peer
14:00:10.846 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.15.31.253:33593(127.15.31.253:33593)] Successfully connected to peer
14:00:10.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:10.876240 16031 heartbeater.cc:499] Master 127.15.31.254:41811 was elected leader, sending a full tablet report...
14:00:10.952 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.15.31.254
14:00:10.953 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.15.31.252
14:00:10.953 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.15.31.253
14:00:11.187 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x2009ca4a, L:/127.0.0.1:39792 - R:/127.15.31.254:41811] using SASL/PLAIN
14:00:11.187 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x6a6a23b1, L:/127.0.0.1:57698 - R:/127.15.31.253:33593] using SASL/PLAIN
14:00:11.188 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x17b8a0e1, L:/127.0.0.1:46156 - R:/127.15.31.252:34123] using SASL/PLAIN
14:00:11.232 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:00:11.233 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=497), Traces: [0ms] refreshing cache from master, [22ms] Sub RPC ConnectToMaster: sending RPC to server master-127.15.31.254:41811, [83ms] Sub RPC ConnectToMaster: sending RPC to server master-127.15.31.252:34123, [85ms] Sub RPC ConnectToMaster: sending RPC to server master-127.15.31.253:33593, [466ms] Sub RPC ConnectToMaster: received response from server master-127.15.31.252:34123: OK, [466ms] Sub RPC ConnectToMaster: received response from server master-127.15.31.253:33593: OK, [467ms] Sub RPC ConnectToMaster: received response from server master-127.15.31.254:41811: OK, deferred=null) after lookup
14:00:11.247 [DEBUG - Time-limited test] (Connection.java:575) [peer master-127.15.31.254:41811(127.15.31.254:41811)] disconnecting while in state READY
14:00:11.253 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.15.31.254:41811(127.15.31.254:41811)] handling channelInactive
14:00:11.254 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.15.31.254:41811(127.15.31.254:41811)] cleaning up while in state READY due to: connection closed
14:00:11.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:11.383008 16170 heartbeater.cc:499] Master 127.15.31.254:41811 was elected leader, sending a full tablet report...
14:00:12.005 [DEBUG - Time-limited test] (Connection.java:748) [peer fake-uuid(127.15.31.254:41811)] connecting to peer
14:00:12.008 [DEBUG - kudu-nio-3] (Connection.java:757) [peer fake-uuid(127.15.31.254:41811)] Successfully connected to peer
14:00:12.078 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x65d49839, L:/127.0.0.1:48428 - R:/127.15.31.254:41811] using TOKEN/null
14:00:12.083 [DEBUG - Time-limited test] (Connection.java:575) [peer master-127.15.31.252:34123(127.15.31.252:34123)] disconnecting while in state READY
14:00:12.084 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.15.31.252:34123(127.15.31.252:34123)] handling channelInactive
14:00:12.085 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.15.31.252:34123(127.15.31.252:34123)] cleaning up while in state READY due to: connection closed
14:00:12.085 [DEBUG - Time-limited test] (Connection.java:575) [peer master-127.15.31.253:33593(127.15.31.253:33593)] disconnecting while in state READY
14:00:12.086 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.15.31.253:33593(127.15.31.253:33593)] handling channelInactive
14:00:12.086 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.15.31.253:33593(127.15.31.253:33593)] cleaning up while in state READY due to: connection closed
14:00:12.337 [DEBUG - Time-limited test] (Connection.java:575) [peer fake-uuid(127.15.31.254:41811)] disconnecting while in state READY
14:00:12.338 [DEBUG - kudu-nio-3] (Connection.java:239) [peer fake-uuid(127.15.31.254:41811)] handling channelInactive
14:00:12.338 [DEBUG - kudu-nio-3] (Connection.java:709) [peer fake-uuid(127.15.31.254:41811)] cleaning up while in state READY due to: connection closed
14:00:12.590 [DEBUG - main] (Connection.java:575) [peer master-127.15.31.252:34123(127.15.31.252:34123)] disconnecting while in state TERMINATED
14:00:12.591 [DEBUG - main] (Connection.java:575) [peer master-127.15.31.253:33593(127.15.31.253:33593)] disconnecting while in state TERMINATED
14:00:12.591 [DEBUG - main] (Connection.java:575) [peer fake-uuid(127.15.31.254:41811)] disconnecting while in state TERMINATED
14:00:12.592 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:00:12.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:12.596226 15487 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu pid 15766
14:00:12.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:12.613137 15888 generic_service.cc:196] Checking for leaks (request via RPC)
14:00:12.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:12.705332 15487 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu with pid 15766
14:00:12.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:12.722281 15487 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu pid 15903
14:00:12.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:12.731071 16025 generic_service.cc:196] Checking for leaks (request via RPC)
14:00:12.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:12.826403 15487 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu with pid 15903
14:00:12.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:12.844543 15487 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu pid 16040
14:00:12.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:12.854019 16164 generic_service.cc:196] Checking for leaks (request via RPC)
14:00:12.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:12.946440 15487 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu with pid 16040
14:00:12.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:12.963868 15487 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu pid 15498
14:00:12.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:12.965325 15559 generic_service.cc:196] Checking for leaks (request via RPC)
14:00:13.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:13.079623 15487 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu with pid 15498
14:00:13.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:00:13.100592 15657 connection.cc:582] server connection from 127.0.0.1:46150 recv error: Network error: recv error from unknown peer: Transport endpoint is not connected (error 107)
14:00:13.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:13.101068 15487 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu pid 15568
14:00:13.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:13.102241 15630 generic_service.cc:196] Checking for leaks (request via RPC)
14:00:13.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:13.212579 15487 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu with pid 15568
14:00:13.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:13.232550 15487 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu pid 15637
14:00:13.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:13.233875 15701 generic_service.cc:196] Checking for leaks (request via RPC)
14:00:13.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:00:13.344698 15487 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskcf9q1j/build/asan/bin/kudu with pid 15637
14:00:13.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:00:13Z chronyd exiting

Time: 8.261

OK (1 test)

