JUnit version 4.13.2
.23:52:06.642 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783468326632
23:52:06.668 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
23:52:06.707 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
23:52:06.715 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskOKr_xz/test-tmp
23:52:06.742 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
23:52:06.745 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskOKr_xz/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
23:52:06.997 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

23:52:07.012 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
23:52:07.013 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

23:52:07.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.015406 29064 mini_oidc.cc:150] Starting JWKS server
23:52:07.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.017549 29064 webserver.cc:534] Webserver started at http://127.0.0.1:38697/ using document root <none> and password file <none>
23:52:07.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.017765 29064 mini_oidc.cc:186] Starting OIDC Discovery server
23:52:07.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.018059 29064 webserver.cc:534] Webserver started at http://127.0.0.1:45693/ using document root <none> and password file <none>
23:52:07.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:52:07Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
23:52:07.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:52:07Z Disabled control of system clock
23:52:07.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.037065 29064 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:07.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:07.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/wal
23:52:07.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/data
23:52:07.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:52:07.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:52:07.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:52:07.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:07.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:07.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:07.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/logs
23:52:07.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/data/info.pb
23:52:07.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:07.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:52:07.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:52:07.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:52:07.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:52:07.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:07.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:07.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:07.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
23:52:07.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:52:07.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:52:07.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:52:07.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.62:39099
23:52:07.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.62
23:52:07.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:07.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:07.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:07.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:07.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:52:07.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:52:07.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:07.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:52:07.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38697/jwks.json with env {}
23:52:07.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.149127 29075 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:52:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.149433 29075 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:52:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.149501 29075 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:52:07.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.153535 29075 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
23:52:07.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.153640 29075 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:52:07.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.153671 29075 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
23:52:07.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.153697 29075 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
23:52:07.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.153728 29075 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
23:52:07.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.153750 29075 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:38697/jwks.json
23:52:07.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.158493 29075 master_runner.cc:387] Master server non-default flags:
23:52:07.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:07.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:07.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:07.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:52:07.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/data
23:52:07.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/wal
23:52:07.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:52:07.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:07.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:07.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:07.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:52:07.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.62:39099
23:52:07.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:52:07.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:52:07.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:52:07.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38697/jwks.json
23:52:07.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:07.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:07.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/data/info.pb
23:52:07.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.62
23:52:07.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:07.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:52:07.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.29075
23:52:07.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:07.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:52:07.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:52:07.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:07.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/logs
23:52:07.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:07.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:52:07.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:52:07.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
23:52:07.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:52:07.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66915500c9e327897c442aea7b3936de4ff5c319
23:52:07.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:52:07.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 23:36:33 UTC on bdcb31816ec0
23:52:07.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16833
23:52:07.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.160189 29075 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:52:07.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.161780 29075 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:52:07.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.168735 29083 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
23:52:07.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.168781 29081 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
23:52:07.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.168735 29080 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
23:52:07.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.169057 29075 server_base.cc:1061] running on GCE node
23:52:07.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.169710 29075 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:52:07.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.170926 29075 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:52:07.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.172147 29075 hybrid_clock.cc:648] HybridClock initialized: now 1783468327172122 us; error 36 us; skew 500 ppm
23:52:07.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.174446 29075 webserver.cc:534] Webserver started at http://127.28.98.62:40309/ using document root <none> and password file <none>
23:52:07.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.175277 29075 fs_manager.cc:362] Metadata directory not provided
23:52:07.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.175372 29075 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:52:07.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.175616 29075 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:52:07.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.177484 29075 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/data/instance:
23:52:07.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0f463ed830cb4b909a83738dfc3bc0d4"
23:52:07.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:07 on dist-test-slave-z2gb"
23:52:07.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.178057 29075 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/wal/instance:
23:52:07.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0f463ed830cb4b909a83738dfc3bc0d4"
23:52:07.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:07 on dist-test-slave-z2gb"
23:52:07.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.182255 29075 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
23:52:07.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.184970 29089 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:52:07.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.186141 29075 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
23:52:07.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.186299 29075 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/data,/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/wal
23:52:07.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0f463ed830cb4b909a83738dfc3bc0d4"
23:52:07.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:07 on dist-test-slave-z2gb"
23:52:07.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.186429 29075 fs_report.cc:389] FS layout report
23:52:07.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:52:07.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/wal
23:52:07.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/wal
23:52:07.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/data/data
23:52:07.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:52:07.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:52:07.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:52:07.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:52:07.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:52:07.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:52:07.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:52:07.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:52:07.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:52:07.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:52:07.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:52:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.222316 29075 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:52:07.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.223310 29075 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
23:52:07.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.223544 29075 kserver.cc:163] Server-wide thread pool size limit: 3276
23:52:07.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.231650 29075 rpc_server.cc:307] RPC server started. Bound to: 127.28.98.62:39099
23:52:07.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.231674 29141 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.28.98.62:39099 every 8 connection(s)
23:52:07.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.232954 29075 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/data/info.pb
23:52:07.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.235811 29064 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu as pid 29075
23:52:07.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.236011 29064 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-0/wal/instance
23:52:07.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.236073 29142 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
23:52:07.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.237687 29064 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:07.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:07.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/wal
23:52:07.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/data
23:52:07.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:52:07.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:52:07.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:52:07.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:07.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:07.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:07.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/logs
23:52:07.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/data/info.pb
23:52:07.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:07.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:52:07.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:52:07.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:52:07.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:52:07.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:07.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:07.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:07.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
23:52:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:52:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:52:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:52:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.61:40115
23:52:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.61
23:52:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:52:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:52:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:07.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:52:07.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38697/jwks.json with env {}
23:52:07.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.239502 29142 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } has no permanent_uuid. Determining permanent_uuid...
23:52:07.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.253876 29142 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } has no permanent_uuid. Determining permanent_uuid...
23:52:07.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.254873 29091 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.28.98.61:40115: connect: Connection refused (error 111)
23:52:07.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.255985 29142 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.28.98.61:40115: Network error: Client connection negotiation failed: client connection to 127.28.98.61:40115: connect: Connection refused (error 111)
23:52:07.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.305222 29142 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } attempt: 1
23:52:07.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.306941 29142 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.28.98.61:40115: Network error: Client connection negotiation failed: client connection to 127.28.98.61:40115: connect: Connection refused (error 111)
23:52:07.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.351668 29144 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:52:07.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.351944 29144 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:52:07.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.351994 29144 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:52:07.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.355713 29144 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
23:52:07.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.355787 29144 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:52:07.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.355809 29144 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
23:52:07.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.355827 29144 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
23:52:07.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.355847 29144 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
23:52:07.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.355862 29144 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:38697/jwks.json
23:52:07.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.361598 29144 master_runner.cc:387] Master server non-default flags:
23:52:07.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:07.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:07.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:07.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:52:07.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/data
23:52:07.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/wal
23:52:07.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:52:07.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:07.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:07.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:07.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:52:07.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.61:40115
23:52:07.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:52:07.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:52:07.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:52:07.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38697/jwks.json
23:52:07.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:07.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:07.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/data/info.pb
23:52:07.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.61
23:52:07.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:07.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:52:07.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.29144
23:52:07.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:07.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:52:07.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:52:07.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:07.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/logs
23:52:07.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:07.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:52:07.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:52:07.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
23:52:07.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:52:07.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66915500c9e327897c442aea7b3936de4ff5c319
23:52:07.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:52:07.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 23:36:33 UTC on bdcb31816ec0
23:52:07.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16833
23:52:07.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.363168 29144 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:52:07.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.364648 29144 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:52:07.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.371637 29152 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
23:52:07.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.371713 29153 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
23:52:07.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.372076 29144 server_base.cc:1061] running on GCE node
23:52:07.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.371680 29155 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
23:52:07.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.372915 29144 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:52:07.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.374035 29144 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:52:07.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.375241 29144 hybrid_clock.cc:648] HybridClock initialized: now 1783468327375220 us; error 48 us; skew 500 ppm
23:52:07.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.375190 29142 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } attempt: 2
23:52:07.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.377316 29142 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.28.98.61:40115: Network error: Client connection negotiation failed: client connection to 127.28.98.61:40115: connect: Connection refused (error 111)
23:52:07.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.377552 29144 webserver.cc:534] Webserver started at http://127.28.98.61:45253/ using document root <none> and password file <none>
23:52:07.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.378223 29144 fs_manager.cc:362] Metadata directory not provided
23:52:07.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.378304 29144 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:52:07.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.378539 29144 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:52:07.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.380653 29144 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/data/instance:
23:52:07.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fc0abaef64214d0ba43594b409a50b3c"
23:52:07.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:07 on dist-test-slave-z2gb"
23:52:07.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.381278 29144 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/wal/instance:
23:52:07.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fc0abaef64214d0ba43594b409a50b3c"
23:52:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:07 on dist-test-slave-z2gb"
23:52:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.385797 29144 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
23:52:07.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.388571 29161 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:52:07.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.389919 29144 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.001s
23:52:07.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.390058 29144 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/data,/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/wal
23:52:07.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fc0abaef64214d0ba43594b409a50b3c"
23:52:07.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:07 on dist-test-slave-z2gb"
23:52:07.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.390163 29144 fs_report.cc:389] FS layout report
23:52:07.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:52:07.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/wal
23:52:07.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/wal
23:52:07.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/data/data
23:52:07.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:52:07.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:52:07.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:52:07.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:52:07.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:52:07.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:52:07.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:52:07.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:52:07.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:52:07.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:52:07.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:52:07.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.424482 29144 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:52:07.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.425303 29144 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
23:52:07.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.425468 29144 kserver.cc:163] Server-wide thread pool size limit: 3276
23:52:07.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.433568 29144 rpc_server.cc:307] RPC server started. Bound to: 127.28.98.61:40115
23:52:07.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.433575 29213 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.28.98.61:40115 every 8 connection(s)
23:52:07.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.434700 29144 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/data/info.pb
23:52:07.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.435266 29064 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu as pid 29144
23:52:07.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.435374 29064 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-1/wal/instance
23:52:07.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.436126 29064 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:07.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:07.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/wal
23:52:07.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/data
23:52:07.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:52:07.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:52:07.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:52:07.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:07.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:07.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:07.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/logs
23:52:07.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/data/info.pb
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.60:43863
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.60
23:52:07.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:07.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:07.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:07.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:07.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:52:07.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:52:07.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:07.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:52:07.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38697/jwks.json with env {}
23:52:07.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.438460 29214 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
23:52:07.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.442723 29214 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } has no permanent_uuid. Determining permanent_uuid...
23:52:07.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.454486 29214 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } has no permanent_uuid. Determining permanent_uuid...
23:52:07.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.461301 29214 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } has no permanent_uuid. Determining permanent_uuid...
23:52:07.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.462235 29162 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.28.98.60:43863: connect: Connection refused (error 111)
23:52:07.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.463281 29214 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.28.98.60:43863: Network error: Client connection negotiation failed: client connection to 127.28.98.60:43863: connect: Connection refused (error 111)
23:52:07.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.468523 29142 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } attempt: 3
23:52:07.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.473306 29142 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } has no permanent_uuid. Determining permanent_uuid...
23:52:07.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.474960 29142 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.28.98.60:43863: Network error: Client connection negotiation failed: client connection to 127.28.98.60:43863: connect: Connection refused (error 111)
23:52:07.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.506170 29142 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } attempt: 1
23:52:07.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.507997 29142 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.28.98.60:43863: Network error: Client connection negotiation failed: client connection to 127.28.98.60:43863: connect: Connection refused (error 111)
23:52:07.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.512542 29214 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } attempt: 1
23:52:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.514328 29214 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.28.98.60:43863: Network error: Client connection negotiation failed: client connection to 127.28.98.60:43863: connect: Connection refused (error 111)
23:52:07.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.564518 29216 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:52:07.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.564808 29216 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:52:07.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.564920 29216 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:52:07.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.568622 29216 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
23:52:07.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.568691 29216 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:52:07.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.568712 29216 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
23:52:07.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.568730 29216 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
23:52:07.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.568786 29216 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
23:52:07.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.568842 29216 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:38697/jwks.json
23:52:07.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.573261 29216 master_runner.cc:387] Master server non-default flags:
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/data
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/wal
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.60:43863
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:52:07.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:52:07.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:52:07.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38697/jwks.json
23:52:07.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:07.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:07.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/data/info.pb
23:52:07.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.60
23:52:07.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:07.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:52:07.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.29216
23:52:07.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:07.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:52:07.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:52:07.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:07.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/logs
23:52:07.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:07.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:52:07.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:52:07.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
23:52:07.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:52:07.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66915500c9e327897c442aea7b3936de4ff5c319
23:52:07.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:52:07.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 23:36:33 UTC on bdcb31816ec0
23:52:07.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16833
23:52:07.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.574616 29216 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:52:07.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.576329 29216 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:52:07.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.582517 29214 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } attempt: 2
23:52:07.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.583190 29142 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } attempt: 2
23:52:07.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.583920 29224 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
23:52:07.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.584424 29227 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
23:52:07.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.585100 29216 server_base.cc:1061] running on GCE node
23:52:07.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.585888 29214 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.28.98.60:43863: Network error: Client connection negotiation failed: client connection to 127.28.98.60:43863: connect: Connection refused (error 111)
23:52:07.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.586093 29225 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
23:52:07.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.586825 29216 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:52:07.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.588167 29216 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:52:07.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.589171 29142 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.28.98.60:43863: Network error: Client connection negotiation failed: client connection to 127.28.98.60:43863: connect: Connection refused (error 111)
23:52:07.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.589705 29216 hybrid_clock.cc:648] HybridClock initialized: now 1783468327589645 us; error 78 us; skew 500 ppm
23:52:07.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.591818 29216 webserver.cc:534] Webserver started at http://127.28.98.60:36903/ using document root <none> and password file <none>
23:52:07.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.592509 29216 fs_manager.cc:362] Metadata directory not provided
23:52:07.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.592602 29216 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:52:07.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.592887 29216 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:52:07.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.594614 29216 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/data/instance:
23:52:07.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "da6eed1a10b843b9921c2779564baf30"
23:52:07.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:07 on dist-test-slave-z2gb"
23:52:07.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.595198 29216 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/wal/instance:
23:52:07.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "da6eed1a10b843b9921c2779564baf30"
23:52:07.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:07 on dist-test-slave-z2gb"
23:52:07.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.599017 29216 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.005s	sys 0.000s
23:52:07.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.601359 29233 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:52:07.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.602398 29216 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
23:52:07.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.602552 29216 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/data,/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/wal
23:52:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "da6eed1a10b843b9921c2779564baf30"
23:52:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:07 on dist-test-slave-z2gb"
23:52:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.602663 29216 fs_report.cc:389] FS layout report
23:52:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:52:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/wal
23:52:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/wal
23:52:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/data/data
23:52:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:52:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:52:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:52:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:52:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:52:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:52:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:52:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:52:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:52:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:52:07.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:52:07.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.633709 29216 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:52:07.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.634680 29216 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
23:52:07.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.634927 29216 kserver.cc:163] Server-wide thread pool size limit: 3276
23:52:07.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.643365 29285 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.28.98.60:43863 every 8 connection(s)
23:52:07.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.643368 29216 rpc_server.cc:307] RPC server started. Bound to: 127.28.98.60:43863
23:52:07.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.644761 29216 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/data/info.pb
23:52:07.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.648588 29286 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
23:52:07.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.650300 29064 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu as pid 29216
23:52:07.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.650436 29064 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/master-2/wal/instance
23:52:07.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.652678 29286 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } has no permanent_uuid. Determining permanent_uuid...
23:52:07.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.663097 29286 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } has no permanent_uuid. Determining permanent_uuid...
23:52:07.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.668987 29286 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } has no permanent_uuid. Determining permanent_uuid...
23:52:07.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.676384 29286 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30: Bootstrap starting.
23:52:07.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.677064 29214 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } attempt: 3
23:52:07.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.679373 29286 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30: Neither blocks nor log segments found. Creating new log.
23:52:07.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.680226 29286 log.cc:826] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30: Log is configured to *not* fsync() on all Append() calls
23:52:07.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.682580 29286 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30: No bootstrap required, opened a new log
23:52:07.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.684386 29214 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c: Bootstrap starting.
23:52:07.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.685765 29286 raft_consensus.cc:359] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } }
23:52:07.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.685947 29286 raft_consensus.cc:385] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:52:07.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.685984 29286 raft_consensus.cc:740] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: da6eed1a10b843b9921c2779564baf30, State: Initialized, Role: FOLLOWER
23:52:07.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.686414 29286 consensus_queue.cc:260] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [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: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } }
23:52:07.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.686873 29295 sys_catalog.cc:455] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [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: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } } }
23:52:07.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.687043 29214 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c: Neither blocks nor log segments found. Creating new log.
23:52:07.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.687556 29295 sys_catalog.cc:458] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [sys.catalog]: This master's current role is: FOLLOWER
23:52:07.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.687927 29214 log.cc:826] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c: Log is configured to *not* fsync() on all Append() calls
23:52:07.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.688354 29142 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } attempt: 3
23:52:07.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.688771 29286 sys_catalog.cc:565] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [sys.catalog]: configured and running, proceeding with master startup.
23:52:07.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.690091 29214 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c: No bootstrap required, opened a new log
23:52:07.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.695122 29214 raft_consensus.cc:359] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } }
23:52:07.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.693423 29216 master_runner.cc:187] Error getting master registration for 127.28.98.62:39099: OK, instance_id { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" instance_seqno: 1783468327229523 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
23:52:07.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.695338 29214 raft_consensus.cc:385] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:52:07.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.695410 29214 raft_consensus.cc:740] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: fc0abaef64214d0ba43594b409a50b3c, State: Initialized, Role: FOLLOWER
23:52:07.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.695447 29216 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
23:52:07.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.695983 29214 consensus_queue.cc:260] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [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: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } }
23:52:07.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.697636 29214 sys_catalog.cc:565] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [sys.catalog]: configured and running, proceeding with master startup.
23:52:07.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.699577 29307 catalog_manager.cc:1593] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
23:52:07.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.699671 29307 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
23:52:07.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.699950 29308 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [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: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } } }
23:52:07.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.700095 29308 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [sys.catalog]: This master's current role is: FOLLOWER
23:52:07.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.700692 29142 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4: Bootstrap starting.
23:52:07.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.703426 29142 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4: Neither blocks nor log segments found. Creating new log.
23:52:07.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.704257 29142 log.cc:826] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4: Log is configured to *not* fsync() on all Append() calls
23:52:07.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.706743 29142 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4: No bootstrap required, opened a new log
23:52:07.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.708134 29320 catalog_manager.cc:1593] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
23:52:07.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.706220 29144 master_runner.cc:187] Error getting master registration for 127.28.98.62:39099: OK, instance_id { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" instance_seqno: 1783468327229523 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
23:52:07.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.708513 29320 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
23:52:07.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.708621 29144 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
23:52:07.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.711817 29142 raft_consensus.cc:359] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } }
23:52:07.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.712059 29142 raft_consensus.cc:385] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:52:07.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.712121 29142 raft_consensus.cc:740] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 0f463ed830cb4b909a83738dfc3bc0d4, State: Initialized, Role: FOLLOWER
23:52:07.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.712630 29142 consensus_queue.cc:260] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [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: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } }
23:52:07.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.713214 29323 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [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: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } } }
23:52:07.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.713346 29323 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [sys.catalog]: This master's current role is: FOLLOWER
23:52:07.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.714149 29142 sys_catalog.cc:565] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [sys.catalog]: configured and running, proceeding with master startup.
23:52:07.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.721179 29334 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
23:52:07.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.721829 29334 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
23:52:07.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.724844 29075 master_runner.cc:264] No leader master found from master 0f463ed830cb4b909a83738dfc3bc0d4
23:52:07.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.724928 29075 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
23:52:07.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.725164 29095 tablet.cc:2406] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:52:07.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.886397 29239 tablet.cc:2406] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:52:07.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:07.927093 29167 tablet.cc:2406] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:52:07.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.929893 29308 raft_consensus.cc:493] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
23:52:07.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.930088 29308 raft_consensus.cc:515] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } }
23:52:07.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.931285 29308 leader_election.cc:290] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 0f463ed830cb4b909a83738dfc3bc0d4 (127.28.98.62:39099), da6eed1a10b843b9921c2779564baf30 (127.28.98.60:43863)
23:52:07.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.932080 29116 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc0abaef64214d0ba43594b409a50b3c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" is_pre_election: true
23:52:07.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.932433 29116 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate fc0abaef64214d0ba43594b409a50b3c in term 0.
23:52:07.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.933015 29164 leader_election.cc:304] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [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: 0f463ed830cb4b909a83738dfc3bc0d4, fc0abaef64214d0ba43594b409a50b3c; no voters: 
23:52:07.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.933426 29308 raft_consensus.cc:2804] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [term 0 FOLLOWER]: Leader pre-election won for term 1
23:52:07.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.933506 29308 raft_consensus.cc:493] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
23:52:07.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.933557 29308 raft_consensus.cc:3060] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [term 0 FOLLOWER]: Advancing to term 1
23:52:07.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.933732 29260 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc0abaef64214d0ba43594b409a50b3c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "da6eed1a10b843b9921c2779564baf30" is_pre_election: true
23:52:07.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.934028 29260 raft_consensus.cc:2468] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate fc0abaef64214d0ba43594b409a50b3c in term 0.
23:52:07.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.934842 29308 raft_consensus.cc:515] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } }
23:52:07.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.935344 29308 leader_election.cc:290] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [CANDIDATE]: Term 1 election: Requested vote from peers 0f463ed830cb4b909a83738dfc3bc0d4 (127.28.98.62:39099), da6eed1a10b843b9921c2779564baf30 (127.28.98.60:43863)
23:52:07.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.936259 29116 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc0abaef64214d0ba43594b409a50b3c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0f463ed830cb4b909a83738dfc3bc0d4"
23:52:07.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.936307 29260 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc0abaef64214d0ba43594b409a50b3c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "da6eed1a10b843b9921c2779564baf30"
23:52:07.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.936434 29260 raft_consensus.cc:3060] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [term 0 FOLLOWER]: Advancing to term 1
23:52:07.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.936424 29116 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [term 0 FOLLOWER]: Advancing to term 1
23:52:07.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.937719 29260 raft_consensus.cc:2468] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate fc0abaef64214d0ba43594b409a50b3c in term 1.
23:52:07.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.937719 29116 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate fc0abaef64214d0ba43594b409a50b3c in term 1.
23:52:07.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.938321 29164 leader_election.cc:304] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [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: 0f463ed830cb4b909a83738dfc3bc0d4, fc0abaef64214d0ba43594b409a50b3c; no voters: 
23:52:07.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.938757 29308 raft_consensus.cc:2804] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [term 1 FOLLOWER]: Leader election won for term 1
23:52:07.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.938978 29308 raft_consensus.cc:697] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [term 1 LEADER]: Becoming Leader. State: Replica: fc0abaef64214d0ba43594b409a50b3c, State: Running, Role: LEADER
23:52:07.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.939399 29308 consensus_queue.cc:237] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [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: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } }
23:52:07.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.944044 29336 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [sys.catalog]: SysCatalogTable state changed. Reason: New leader fc0abaef64214d0ba43594b409a50b3c. Latest consensus state: current_term: 1 leader_uuid: "fc0abaef64214d0ba43594b409a50b3c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } } }
23:52:07.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.949638 29336 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [sys.catalog]: This master's current role is: LEADER
23:52:07.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.950953 29338 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
23:52:07.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.952634 29338 catalog_manager.cc:1519] Initializing Kudu cluster ID...
23:52:07.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.959795 29260 raft_consensus.cc:1275] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [term 1 FOLLOWER]: Refusing update from remote peer fc0abaef64214d0ba43594b409a50b3c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
23:52:07.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.959873 29116 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [term 1 FOLLOWER]: Refusing update from remote peer fc0abaef64214d0ba43594b409a50b3c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
23:52:07.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.960834 29308 consensus_queue.cc:1048] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [LEADER]: Connected to new peer: Peer: permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:52:07.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.961364 29308 consensus_queue.cc:1048] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [LEADER]: Connected to new peer: Peer: permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:52:07.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.966436 29295 sys_catalog.cc:455] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [sys.catalog]: SysCatalogTable state changed. Reason: New leader fc0abaef64214d0ba43594b409a50b3c. Latest consensus state: current_term: 1 leader_uuid: "fc0abaef64214d0ba43594b409a50b3c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } } }
23:52:07.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.966611 29295 sys_catalog.cc:458] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [sys.catalog]: This master's current role is: FOLLOWER
23:52:07.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.967090 29323 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [sys.catalog]: SysCatalogTable state changed. Reason: New leader fc0abaef64214d0ba43594b409a50b3c. Latest consensus state: current_term: 1 leader_uuid: "fc0abaef64214d0ba43594b409a50b3c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } } }
23:52:07.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.967221 29323 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [sys.catalog]: This master's current role is: FOLLOWER
23:52:07.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.972236 29308 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "fc0abaef64214d0ba43594b409a50b3c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } } }
23:52:07.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.972416 29308 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [sys.catalog]: This master's current role is: LEADER
23:52:07.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.972702 29339 mvcc.cc:204] Tried to move back new op lower bound from 7305086271314923520 to 7305086271244058624. Current Snapshot: MvccSnapshot[applied={T|T < 7305086271314923520}]
23:52:07.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.973600 29323 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "fc0abaef64214d0ba43594b409a50b3c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } } }
23:52:07.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.973768 29323 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4 [sys.catalog]: This master's current role is: FOLLOWER
23:52:07.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.974910 29336 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "fc0abaef64214d0ba43594b409a50b3c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } } }
23:52:07.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.975042 29336 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c [sys.catalog]: This master's current role is: LEADER
23:52:07.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.975483 29338 catalog_manager.cc:1382] Generated new cluster ID: 3a533a08efc04bb18111f9bb6b7c81dd
23:52:07.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.975545 29338 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
23:52:07.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.977339 29341 mvcc.cc:204] Tried to move back new op lower bound from 7305086271314923520 to 7305086271244058624. Current Snapshot: MvccSnapshot[applied={T|T < 7305086271314923520}]
23:52:07.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.983057 29295 sys_catalog.cc:455] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "fc0abaef64214d0ba43594b409a50b3c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0f463ed830cb4b909a83738dfc3bc0d4" member_type: VOTER last_known_addr { host: "127.28.98.62" port: 39099 } } peers { permanent_uuid: "fc0abaef64214d0ba43594b409a50b3c" member_type: VOTER last_known_addr { host: "127.28.98.61" port: 40115 } } peers { permanent_uuid: "da6eed1a10b843b9921c2779564baf30" member_type: VOTER last_known_addr { host: "127.28.98.60" port: 43863 } } }
23:52:07.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.983206 29295 sys_catalog.cc:458] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30 [sys.catalog]: This master's current role is: FOLLOWER
23:52:07.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:07.984007 29340 mvcc.cc:204] Tried to move back new op lower bound from 7305086271314923520 to 7305086271244058624. Current Snapshot: MvccSnapshot[applied={T|T < 7305086271314923520}]
23:52:08.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.001039 29338 catalog_manager.cc:1405] Generated new certificate authority record
23:52:08.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.002573 29338 catalog_manager.cc:1539] Loading token signing keys...
23:52:08.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.010536 29338 catalog_manager.cc:6069] T 00000000000000000000000000000000 P fc0abaef64214d0ba43594b409a50b3c: Generated new TSK 0
23:52:08.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.011619 29338 catalog_manager.cc:1549] Initializing in-progress tserver states...
23:52:08.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.036541 29064 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/wal
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/data
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/logs
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/data/info.pb
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:08.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:52:08.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:52:08.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.1:0
23:52:08.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.98.1
23:52:08.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.1
23:52:08.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:08.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:08.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:08.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:08.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:08.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
23:52:08.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.146849 29348 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:52:08.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.147102 29348 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:52:08.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.147147 29348 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:52:08.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.150660 29348 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:52:08.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.150787 29348 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.28.98.1
23:52:08.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.154965 29348 tablet_server_runner.cc:78] Tablet server non-default flags:
23:52:08.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:08.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:08.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:08.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:52:08.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/data
23:52:08.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/wal
23:52:08.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:08.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:08.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.1:0
23:52:08.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:52:08.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:08.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:08.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/data/info.pb
23:52:08.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.1
23:52:08.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:08.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:08.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:52:08.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.29348
23:52:08.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:08.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:52:08.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:52:08.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:08.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.98.1
23:52:08.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/logs
23:52:08.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:08.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:52:08.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:52:08.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:52:08.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:52:08.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66915500c9e327897c442aea7b3936de4ff5c319
23:52:08.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:52:08.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 23:36:33 UTC on bdcb31816ec0
23:52:08.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16833
23:52:08.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.156281 29348 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:52:08.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.157873 29348 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:52:08.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.165091 29353 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
23:52:08.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.165199 29356 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
23:52:08.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.165091 29354 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
23:52:08.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.165706 29348 server_base.cc:1061] running on GCE node
23:52:08.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.166177 29348 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:52:08.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.166893 29348 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:52:08.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.168076 29348 hybrid_clock.cc:648] HybridClock initialized: now 1783468328168054 us; error 42 us; skew 500 ppm
23:52:08.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.170156 29348 webserver.cc:534] Webserver started at http://127.28.98.1:33429/ using document root <none> and password file <none>
23:52:08.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.170957 29348 fs_manager.cc:362] Metadata directory not provided
23:52:08.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.171288 29348 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:52:08.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.171597 29348 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:52:08.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.173465 29348 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/data/instance:
23:52:08.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9631a322f0ce4cbfb37664951d77e35d"
23:52:08.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:08 on dist-test-slave-z2gb"
23:52:08.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.174057 29348 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/wal/instance:
23:52:08.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9631a322f0ce4cbfb37664951d77e35d"
23:52:08.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:08 on dist-test-slave-z2gb"
23:52:08.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.177811 29348 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.004s	sys 0.000s
23:52:08.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.180254 29362 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:52:08.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.181473 29348 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.001s
23:52:08.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.181577 29348 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/data,/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/wal
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9631a322f0ce4cbfb37664951d77e35d"
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:08 on dist-test-slave-z2gb"
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.181699 29348 fs_report.cc:389] FS layout report
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/wal
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/wal
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/data/data
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:52:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:52:08.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:52:08.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:52:08.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:52:08.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:52:08.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:52:08.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.201346 29348 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:52:08.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.202011 29348 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
23:52:08.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.202167 29348 kserver.cc:163] Server-wide thread pool size limit: 3276
23:52:08.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.202759 29348 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
23:52:08.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.203809 29348 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:52:08.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.203858 29348 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:52:08.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.203900 29348 ts_tablet_manager.cc:616] Registered 0 tablets
23:52:08.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.203915 29348 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:52:08.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.214311 29348 rpc_server.cc:307] RPC server started. Bound to: 127.28.98.1:43657
23:52:08.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.214334 29476 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.28.98.1:43657 every 8 connection(s)
23:52:08.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.215376 29348 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/data/info.pb
23:52:08.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.223251 29064 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu as pid 29348
23:52:08.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.223387 29064 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-0/wal/instance
23:52:08.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.226363 29064 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/wal
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/data
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/logs
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/data/info.pb
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:08.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.2:0
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.98.2
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.2
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:08.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.226460 29477 heartbeater.cc:344] Connected to a master server at 127.28.98.60:43863
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.226481 29478 heartbeater.cc:344] Connected to a master server at 127.28.98.62:39099
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.226686 29478 heartbeater.cc:461] Registering TS with master...
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.226687 29477 heartbeater.cc:461] Registering TS with master...
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.227375 29478 heartbeater.cc:507] Master 127.28.98.62:39099 requested a full tablet report, sending...
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.227375 29477 heartbeater.cc:507] Master 127.28.98.60:43863 requested a full tablet report, sending...
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.229177 29250 ts_manager.cc:194] Registered new tserver with Master: 9631a322f0ce4cbfb37664951d77e35d (127.28.98.1:43657)
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.229789 29479 heartbeater.cc:344] Connected to a master server at 127.28.98.61:40115
23:52:08.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.229874 29479 heartbeater.cc:461] Registering TS with master...
23:52:08.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.230079 29479 heartbeater.cc:507] Master 127.28.98.61:40115 requested a full tablet report, sending...
23:52:08.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.230952 29106 ts_manager.cc:194] Registered new tserver with Master: 9631a322f0ce4cbfb37664951d77e35d (127.28.98.1:43657)
23:52:08.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.230974 29178 ts_manager.cc:194] Registered new tserver with Master: 9631a322f0ce4cbfb37664951d77e35d (127.28.98.1:43657)
23:52:08.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.232503 29178 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.28.98.1:57637
23:52:08.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.339401 29487 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:52:08.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.339707 29487 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:52:08.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.339776 29487 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:52:08.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.343601 29487 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:52:08.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.343763 29487 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.28.98.2
23:52:08.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.347911 29487 tablet_server_runner.cc:78] Tablet server non-default flags:
23:52:08.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:08.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:08.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:08.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:52:08.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/data
23:52:08.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/wal
23:52:08.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:08.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:08.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.2:0
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/data/info.pb
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.2
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.29487
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.98.2
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/logs
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:08.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:52:08.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:52:08.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:52:08.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:52:08.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66915500c9e327897c442aea7b3936de4ff5c319
23:52:08.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:52:08.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 23:36:33 UTC on bdcb31816ec0
23:52:08.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16833
23:52:08.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.349529 29487 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:52:08.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.350975 29487 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:52:08.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.357880 29495 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
23:52:08.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.357880 29492 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
23:52:08.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.357928 29493 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
23:52:08.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.358100 29487 server_base.cc:1061] running on GCE node
23:52:08.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.358891 29487 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:52:08.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.359408 29487 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:52:08.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.360595 29487 hybrid_clock.cc:648] HybridClock initialized: now 1783468328360574 us; error 35 us; skew 500 ppm
23:52:08.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.362490 29487 webserver.cc:534] Webserver started at http://127.28.98.2:43623/ using document root <none> and password file <none>
23:52:08.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.363129 29487 fs_manager.cc:362] Metadata directory not provided
23:52:08.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.363217 29487 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:52:08.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.363461 29487 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:52:08.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.365314 29487 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/data/instance:
23:52:08.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3e46ae66aba04cb0b29ede3fb2950f89"
23:52:08.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:08 on dist-test-slave-z2gb"
23:52:08.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.365911 29487 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/wal/instance:
23:52:08.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3e46ae66aba04cb0b29ede3fb2950f89"
23:52:08.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:08 on dist-test-slave-z2gb"
23:52:08.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.369570 29487 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.004s	sys 0.000s
23:52:08.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.371968 29501 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:52:08.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.373175 29487 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.001s
23:52:08.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.373274 29487 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/data,/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/wal
23:52:08.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3e46ae66aba04cb0b29ede3fb2950f89"
23:52:08.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:08 on dist-test-slave-z2gb"
23:52:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.373354 29487 fs_report.cc:389] FS layout report
23:52:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:52:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/wal
23:52:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/wal
23:52:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/data/data
23:52:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:52:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:52:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:52:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:52:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:52:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:52:08.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:52:08.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:52:08.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:52:08.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:52:08.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:52:08.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.408383 29487 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:52:08.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.409175 29487 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
23:52:08.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.409346 29487 kserver.cc:163] Server-wide thread pool size limit: 3276
23:52:08.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.409883 29487 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
23:52:08.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.410950 29487 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:52:08.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.411003 29487 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:52:08.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.411047 29487 ts_tablet_manager.cc:616] Registered 0 tablets
23:52:08.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.411062 29487 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:52:08.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.421444 29487 rpc_server.cc:307] RPC server started. Bound to: 127.28.98.2:35733
23:52:08.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.421464 29615 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.28.98.2:35733 every 8 connection(s)
23:52:08.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.422725 29487 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/data/info.pb
23:52:08.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.425051 29064 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu as pid 29487
23:52:08.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.425177 29064 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-1/wal/instance
23:52:08.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.427928 29064 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:08.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu
23:52:08.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/wal
23:52:08.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/data
23:52:08.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/logs
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/data/info.pb
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:08.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:52:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:52:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.3:0
23:52:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.98.3
23:52:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.3
23:52:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:08.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
23:52:08.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.434137 29617 heartbeater.cc:344] Connected to a master server at 127.28.98.62:39099
23:52:08.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.434429 29617 heartbeater.cc:461] Registering TS with master...
23:52:08.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.435492 29617 heartbeater.cc:507] Master 127.28.98.62:39099 requested a full tablet report, sending...
23:52:08.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.436839 29106 ts_manager.cc:194] Registered new tserver with Master: 3e46ae66aba04cb0b29ede3fb2950f89 (127.28.98.2:35733)
23:52:08.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.437687 29616 heartbeater.cc:344] Connected to a master server at 127.28.98.60:43863
23:52:08.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.437794 29616 heartbeater.cc:461] Registering TS with master...
23:52:08.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.437881 29618 heartbeater.cc:344] Connected to a master server at 127.28.98.61:40115
23:52:08.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.437973 29618 heartbeater.cc:461] Registering TS with master...
23:52:08.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.438019 29616 heartbeater.cc:507] Master 127.28.98.60:43863 requested a full tablet report, sending...
23:52:08.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.438202 29618 heartbeater.cc:507] Master 127.28.98.61:40115 requested a full tablet report, sending...
23:52:08.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.438791 29250 ts_manager.cc:194] Registered new tserver with Master: 3e46ae66aba04cb0b29ede3fb2950f89 (127.28.98.2:35733)
23:52:08.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.438920 29178 ts_manager.cc:194] Registered new tserver with Master: 3e46ae66aba04cb0b29ede3fb2950f89 (127.28.98.2:35733)
23:52:08.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.439628 29178 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.28.98.2:40175
23:52:08.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.545137 29623 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:52:08.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.545387 29623 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:52:08.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.545431 29623 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:52:08.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.549065 29623 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:52:08.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.549187 29623 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.28.98.3
23:52:08.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.553417 29623 tablet_server_runner.cc:78] Tablet server non-default flags:
23:52:08.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:52:08.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.98.20:42455
23:52:08.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/data
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/wal
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.98.3:0
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/data/info.pb
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.98.3
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.98.62:39099,127.28.98.61:40115,127.28.98.60:43863
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:52:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.29623
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.98.3
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/logs
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66915500c9e327897c442aea7b3936de4ff5c319
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 23:36:33 UTC on bdcb31816ec0
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16833
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.554632 29623 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:52:08.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.555759 29623 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:52:08.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.562525 29629 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
23:52:08.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.562522 29628 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
23:52:08.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:08.562522 29631 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
23:52:08.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.563115 29623 server_base.cc:1061] running on GCE node
23:52:08.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.563482 29623 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:52:08.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.564111 29623 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:52:08.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.565286 29623 hybrid_clock.cc:648] HybridClock initialized: now 1783468328565258 us; error 49 us; skew 500 ppm
23:52:08.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.567186 29623 webserver.cc:534] Webserver started at http://127.28.98.3:33237/ using document root <none> and password file <none>
23:52:08.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.567749 29623 fs_manager.cc:362] Metadata directory not provided
23:52:08.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.567804 29623 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:52:08.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.567978 29623 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:52:08.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.570222 29623 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/data/instance:
23:52:08.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aa09f00db11e4f13be92350c44060103"
23:52:08.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:08 on dist-test-slave-z2gb"
23:52:08.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.570868 29623 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/wal/instance:
23:52:08.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aa09f00db11e4f13be92350c44060103"
23:52:08.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:08 on dist-test-slave-z2gb"
23:52:08.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.575434 29623 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.002s	sys 0.004s
23:52:08.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.577744 29637 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.578836 29623 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.578980 29623 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/data,/tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/wal
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aa09f00db11e4f13be92350c44060103"
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:52:08 on dist-test-slave-z2gb"
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.579069 29623 fs_report.cc:389] FS layout report
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/wal
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/wal
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/data/data
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:52:08.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:52:08.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.606498 29623 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:52:08.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.607167 29623 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
23:52:08.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.607323 29623 kserver.cc:163] Server-wide thread pool size limit: 3276
23:52:08.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.607856 29623 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
23:52:08.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.608981 29623 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:52:08.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.609031 29623 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:52:08.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.609076 29623 ts_tablet_manager.cc:616] Registered 0 tablets
23:52:08.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.609090 29623 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:52:08.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.618973 29623 rpc_server.cc:307] RPC server started. Bound to: 127.28.98.3:42363
23:52:08.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.618997 29751 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.28.98.3:42363 every 8 connection(s)
23:52:08.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.620066 29623 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/data/info.pb
23:52:08.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.629932 29064 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu as pid 29623
23:52:08.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.630080 29064 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOKr_xz/test-tmp/mini-kudu-cluster7499115235435490736/ts-2/wal/instance
23:52:08.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.630089 29753 heartbeater.cc:344] Connected to a master server at 127.28.98.62:39099
23:52:08.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.630093 29752 heartbeater.cc:344] Connected to a master server at 127.28.98.60:43863
23:52:08.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.630407 29753 heartbeater.cc:461] Registering TS with master...
23:52:08.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.630407 29752 heartbeater.cc:461] Registering TS with master...
23:52:08.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.630935 29754 heartbeater.cc:344] Connected to a master server at 127.28.98.61:40115
23:52:08.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.631115 29752 heartbeater.cc:507] Master 127.28.98.60:43863 requested a full tablet report, sending...
23:52:08.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.631268 29754 heartbeater.cc:461] Registering TS with master...
23:52:08.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.631481 29754 heartbeater.cc:507] Master 127.28.98.61:40115 requested a full tablet report, sending...
23:52:08.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.631115 29753 heartbeater.cc:507] Master 127.28.98.62:39099 requested a full tablet report, sending...
23:52:08.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.632385 29178 ts_manager.cc:194] Registered new tserver with Master: aa09f00db11e4f13be92350c44060103 (127.28.98.3:42363)
23:52:08.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.632463 29105 ts_manager.cc:194] Registered new tserver with Master: aa09f00db11e4f13be92350c44060103 (127.28.98.3:42363)
23:52:08.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.633152 29178 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.28.98.3:52655
23:52:08.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.633299 29250 ts_manager.cc:194] Registered new tserver with Master: aa09f00db11e4f13be92350c44060103 (127.28.98.3:42363)
23:52:08.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.636991 29064 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
23:52:08.638 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
23:52:08.639 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

23:52:08.648 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.28.98.62"
      port: 39099
    }
    bound_http_address {
      host: "127.28.98.62"
      port: 40309
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.28.98.61"
      port: 40115
    }
    bound_http_address {
      host: "127.28.98.61"
      port: 45253
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.28.98.60"
      port: 43863
    }
    bound_http_address {
      host: "127.28.98.60"
      port: 36903
    }
  }
}

23:52:08.652 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

23:52:08.654 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.28.98.1"
      port: 43657
    }
    bound_http_address {
      host: "127.28.98.1"
      port: 33429
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.28.98.2"
      port: 35733
    }
    bound_http_address {
      host: "127.28.98.2"
      port: 43623
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.28.98.3"
      port: 42363
    }
    bound_http_address {
      host: "127.28.98.3"
      port: 33237
    }
  }
}

23:52:08.654 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
23:52:08.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.701170 29307 catalog_manager.cc:1294] Loaded cluster ID: 3a533a08efc04bb18111f9bb6b7c81dd
23:52:08.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.701258 29307 catalog_manager.cc:1587] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30: loading cluster ID for follower catalog manager: success
23:52:08.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.703622 29307 catalog_manager.cc:1609] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30: acquiring CA information for follower catalog manager: success
23:52:08.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.705108 29307 catalog_manager.cc:1637] T 00000000000000000000000000000000 P da6eed1a10b843b9921c2779564baf30: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
23:52:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.723675 29334 catalog_manager.cc:1294] Loaded cluster ID: 3a533a08efc04bb18111f9bb6b7c81dd
23:52:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.723795 29334 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4: loading cluster ID for follower catalog manager: success
23:52:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.726567 29334 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4: acquiring CA information for follower catalog manager: success
23:52:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:08.728013 29334 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 0f463ed830cb4b909a83738dfc3bc0d4: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
23:52:08.829 [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.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	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)
23:52:08.885 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
23:52:09.030 [DEBUG - main] (Connection.java:748) [peer master-127.28.98.62:39099(127.28.98.62:39099)] connecting to peer
23:52:09.081 [DEBUG - main] (Connection.java:748) [peer master-127.28.98.60:43863(127.28.98.60:43863)] connecting to peer
23:52:09.083 [DEBUG - main] (Connection.java:748) [peer master-127.28.98.61:40115(127.28.98.61:40115)] connecting to peer
23:52:09.099 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.28.98.60:43863(127.28.98.60:43863)] Successfully connected to peer
23:52:09.099 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.28.98.61:40115(127.28.98.61:40115)] Successfully connected to peer
23:52:09.100 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.28.98.62:39099(127.28.98.62:39099)] Successfully connected to peer
23:52:09.191 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.28.98.61
23:52:09.191 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.28.98.62
23:52:09.197 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.28.98.60
23:52:09.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.235076 29479 heartbeater.cc:499] Master 127.28.98.61:40115 was elected leader, sending a full tablet report...
23:52:09.410 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x8d80302f, L:/127.0.0.1:50180 - R:/127.28.98.61:40115] using SASL/PLAIN
23:52:09.410 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x2ccca233, L:/127.0.0.1:41638 - R:/127.28.98.60:43863] using SASL/PLAIN
23:52:09.411 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xa089c0f2, L:/127.0.0.1:52756 - R:/127.28.98.62:39099] using SASL/PLAIN
23:52:09.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.441718 29618 heartbeater.cc:499] Master 127.28.98.61:40115 was elected leader, sending a full tablet report...
23:52:09.448 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
23:52:09.449 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=458), Traces: [0ms] refreshing cache from master, [26ms] Sub RPC ConnectToMaster: sending RPC to server master-127.28.98.62:39099, [87ms] Sub RPC ConnectToMaster: sending RPC to server master-127.28.98.60:43863, [88ms] Sub RPC ConnectToMaster: sending RPC to server master-127.28.98.61:40115, [430ms] Sub RPC ConnectToMaster: received response from server master-127.28.98.60:43863: OK, [430ms] Sub RPC ConnectToMaster: received response from server master-127.28.98.62:39099: OK, [431ms] Sub RPC ConnectToMaster: received response from server master-127.28.98.61:40115: OK, deferred=null) after lookup
23:52:09.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.498941 29178 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:50180:
23:52:09.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783468326531"
23:52:09.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
23:52:09.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:52:09.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
23:52:09.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
23:52:09.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
23:52:09.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:52:09.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
23:52:09.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:09.500447 29178 catalog_manager.cc:7076] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1783468326531 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
23:52:09.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.525463 29686 tablet_service.cc:1511] Processing CreateTablet for tablet b72f65cc87e74f4193b82af8ef1f411e (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783468326531 [id=c6fa534c44564d22b260165b05122397]), partition=RANGE (key) PARTITION UNBOUNDED
23:52:09.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.525460 29550 tablet_service.cc:1511] Processing CreateTablet for tablet b72f65cc87e74f4193b82af8ef1f411e (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783468326531 [id=c6fa534c44564d22b260165b05122397]), partition=RANGE (key) PARTITION UNBOUNDED
23:52:09.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.526477 29550 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet b72f65cc87e74f4193b82af8ef1f411e. 1 dirs total, 0 dirs full, 0 dirs failed
23:52:09.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.527793 29410 tablet_service.cc:1511] Processing CreateTablet for tablet b72f65cc87e74f4193b82af8ef1f411e (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783468326531 [id=c6fa534c44564d22b260165b05122397]), partition=RANGE (key) PARTITION UNBOUNDED
23:52:09.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.528658 29410 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet b72f65cc87e74f4193b82af8ef1f411e. 1 dirs total, 0 dirs full, 0 dirs failed
23:52:09.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.531848 29783 tablet_bootstrap.cc:492] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89: Bootstrap starting.
23:52:09.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.533224 29686 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet b72f65cc87e74f4193b82af8ef1f411e. 1 dirs total, 0 dirs full, 0 dirs failed
23:52:09.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.536418 29783 tablet_bootstrap.cc:654] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89: Neither blocks nor log segments found. Creating new log.
23:52:09.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.537827 29783 log.cc:826] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89: Log is configured to *not* fsync() on all Append() calls
23:52:09.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.539391 29786 tablet_bootstrap.cc:492] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103: Bootstrap starting.
23:52:09.539 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:894) Opened table c6fa534c44564d22b260165b05122397
23:52:09.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.540287 29784 tablet_bootstrap.cc:492] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d: Bootstrap starting.
23:52:09.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.542006 29786 tablet_bootstrap.cc:654] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103: Neither blocks nor log segments found. Creating new log.
23:52:09.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.542351 29783 tablet_bootstrap.cc:492] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89: No bootstrap required, opened a new log
23:52:09.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.542619 29783 ts_tablet_manager.cc:1403] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89: Time spent bootstrapping tablet: real 0.011s	user 0.004s	sys 0.000s
23:52:09.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.543087 29786 log.cc:826] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103: Log is configured to *not* fsync() on all Append() calls
23:52:09.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.543162 29784 tablet_bootstrap.cc:654] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d: Neither blocks nor log segments found. Creating new log.
23:52:09.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.543932 29784 log.cc:826] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d: Log is configured to *not* fsync() on all Append() calls
23:52:09.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.544943 29786 tablet_bootstrap.cc:492] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103: No bootstrap required, opened a new log
23:52:09.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.545169 29786 ts_tablet_manager.cc:1403] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103: Time spent bootstrapping tablet: real 0.006s	user 0.005s	sys 0.000s
23:52:09.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.546672 29783 raft_consensus.cc:359] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9631a322f0ce4cbfb37664951d77e35d" member_type: VOTER last_known_addr { host: "127.28.98.1" port: 43657 } } peers { permanent_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" member_type: VOTER last_known_addr { host: "127.28.98.2" port: 35733 } } peers { permanent_uuid: "aa09f00db11e4f13be92350c44060103" member_type: VOTER last_known_addr { host: "127.28.98.3" port: 42363 } }
23:52:09.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.546917 29783 raft_consensus.cc:385] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:52:09.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.546977 29783 raft_consensus.cc:740] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3e46ae66aba04cb0b29ede3fb2950f89, State: Initialized, Role: FOLLOWER
23:52:09.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.547549 29783 consensus_queue.cc:260] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [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: "9631a322f0ce4cbfb37664951d77e35d" member_type: VOTER last_known_addr { host: "127.28.98.1" port: 43657 } } peers { permanent_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" member_type: VOTER last_known_addr { host: "127.28.98.2" port: 35733 } } peers { permanent_uuid: "aa09f00db11e4f13be92350c44060103" member_type: VOTER last_known_addr { host: "127.28.98.3" port: 42363 } }
23:52:09.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.548187 29786 raft_consensus.cc:359] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9631a322f0ce4cbfb37664951d77e35d" member_type: VOTER last_known_addr { host: "127.28.98.1" port: 43657 } } peers { permanent_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" member_type: VOTER last_known_addr { host: "127.28.98.2" port: 35733 } } peers { permanent_uuid: "aa09f00db11e4f13be92350c44060103" member_type: VOTER last_known_addr { host: "127.28.98.3" port: 42363 } }
23:52:09.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.548393 29786 raft_consensus.cc:385] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:52:09.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.548452 29786 raft_consensus.cc:740] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: aa09f00db11e4f13be92350c44060103, State: Initialized, Role: FOLLOWER
23:52:09.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.548537 29783 ts_tablet_manager.cc:1434] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89: Time spent starting tablet: real 0.006s	user 0.001s	sys 0.006s
23:52:09.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.548959 29786 consensus_queue.cc:260] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103 [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: "9631a322f0ce4cbfb37664951d77e35d" member_type: VOTER last_known_addr { host: "127.28.98.1" port: 43657 } } peers { permanent_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" member_type: VOTER last_known_addr { host: "127.28.98.2" port: 35733 } } peers { permanent_uuid: "aa09f00db11e4f13be92350c44060103" member_type: VOTER last_known_addr { host: "127.28.98.3" port: 42363 } }
23:52:09.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.549837 29786 ts_tablet_manager.cc:1434] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103: Time spent starting tablet: real 0.004s	user 0.004s	sys 0.000s
23:52:09.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.552006 29754 heartbeater.cc:499] Master 127.28.98.61:40115 was elected leader, sending a full tablet report...
23:52:09.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.561879 29784 tablet_bootstrap.cc:492] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d: No bootstrap required, opened a new log
23:52:09.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.562568 29784 ts_tablet_manager.cc:1403] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d: Time spent bootstrapping tablet: real 0.022s	user 0.005s	sys 0.000s
23:52:09.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.567209 29784 raft_consensus.cc:359] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9631a322f0ce4cbfb37664951d77e35d" member_type: VOTER last_known_addr { host: "127.28.98.1" port: 43657 } } peers { permanent_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" member_type: VOTER last_known_addr { host: "127.28.98.2" port: 35733 } } peers { permanent_uuid: "aa09f00db11e4f13be92350c44060103" member_type: VOTER last_known_addr { host: "127.28.98.3" port: 42363 } }
23:52:09.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.567447 29784 raft_consensus.cc:385] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:52:09.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.567495 29784 raft_consensus.cc:740] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 9631a322f0ce4cbfb37664951d77e35d, State: Initialized, Role: FOLLOWER
23:52:09.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.567972 29784 consensus_queue.cc:260] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d [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: "9631a322f0ce4cbfb37664951d77e35d" member_type: VOTER last_known_addr { host: "127.28.98.1" port: 43657 } } peers { permanent_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" member_type: VOTER last_known_addr { host: "127.28.98.2" port: 35733 } } peers { permanent_uuid: "aa09f00db11e4f13be92350c44060103" member_type: VOTER last_known_addr { host: "127.28.98.3" port: 42363 } }
23:52:09.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.568948 29784 ts_tablet_manager.cc:1434] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d: Time spent starting tablet: real 0.006s	user 0.006s	sys 0.000s
23:52:09.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:09.622001 29755 tablet.cc:2406] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:52:09.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:09.674631 29619 tablet.cc:2406] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:52:09.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.697849 29789 raft_consensus.cc:493] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
23:52:09.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.698037 29789 raft_consensus.cc:515] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9631a322f0ce4cbfb37664951d77e35d" member_type: VOTER last_known_addr { host: "127.28.98.1" port: 43657 } } peers { permanent_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" member_type: VOTER last_known_addr { host: "127.28.98.2" port: 35733 } } peers { permanent_uuid: "aa09f00db11e4f13be92350c44060103" member_type: VOTER last_known_addr { host: "127.28.98.3" port: 42363 } }
23:52:09.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.699156 29789 leader_election.cc:290] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 9631a322f0ce4cbfb37664951d77e35d (127.28.98.1:43657), aa09f00db11e4f13be92350c44060103 (127.28.98.3:42363)
23:52:09.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.703768 29430 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b72f65cc87e74f4193b82af8ef1f411e" candidate_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "9631a322f0ce4cbfb37664951d77e35d" is_pre_election: true
23:52:09.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.703783 29706 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b72f65cc87e74f4193b82af8ef1f411e" candidate_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "aa09f00db11e4f13be92350c44060103" is_pre_election: true
23:52:09.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.704056 29706 raft_consensus.cc:2468] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 3e46ae66aba04cb0b29ede3fb2950f89 in term 0.
23:52:09.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.704068 29430 raft_consensus.cc:2468] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 3e46ae66aba04cb0b29ede3fb2950f89 in term 0.
23:52:09.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.704542 29502 leader_election.cc:304] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [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: 3e46ae66aba04cb0b29ede3fb2950f89, 9631a322f0ce4cbfb37664951d77e35d; no voters: 
23:52:09.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.704872 29789 raft_consensus.cc:2804] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [term 0 FOLLOWER]: Leader pre-election won for term 1
23:52:09.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.704943 29789 raft_consensus.cc:493] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
23:52:09.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.704974 29789 raft_consensus.cc:3060] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [term 0 FOLLOWER]: Advancing to term 1
23:52:09.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.705945 29789 raft_consensus.cc:515] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9631a322f0ce4cbfb37664951d77e35d" member_type: VOTER last_known_addr { host: "127.28.98.1" port: 43657 } } peers { permanent_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" member_type: VOTER last_known_addr { host: "127.28.98.2" port: 35733 } } peers { permanent_uuid: "aa09f00db11e4f13be92350c44060103" member_type: VOTER last_known_addr { host: "127.28.98.3" port: 42363 } }
23:52:09.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.706326 29789 leader_election.cc:290] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [CANDIDATE]: Term 1 election: Requested vote from peers 9631a322f0ce4cbfb37664951d77e35d (127.28.98.1:43657), aa09f00db11e4f13be92350c44060103 (127.28.98.3:42363)
23:52:09.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.706732 29706 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b72f65cc87e74f4193b82af8ef1f411e" candidate_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "aa09f00db11e4f13be92350c44060103"
23:52:09.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.706785 29430 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b72f65cc87e74f4193b82af8ef1f411e" candidate_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "9631a322f0ce4cbfb37664951d77e35d"
23:52:09.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.706897 29430 raft_consensus.cc:3060] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d [term 0 FOLLOWER]: Advancing to term 1
23:52:09.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.706880 29706 raft_consensus.cc:3060] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103 [term 0 FOLLOWER]: Advancing to term 1
23:52:09.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.707916 29430 raft_consensus.cc:2468] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 3e46ae66aba04cb0b29ede3fb2950f89 in term 1.
23:52:09.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.707945 29706 raft_consensus.cc:2468] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 3e46ae66aba04cb0b29ede3fb2950f89 in term 1.
23:52:09.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.708351 29505 leader_election.cc:304] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 3 responses out of 3 voters: 3 yes votes; 0 no votes. yes voters: 3e46ae66aba04cb0b29ede3fb2950f89, 9631a322f0ce4cbfb37664951d77e35d, aa09f00db11e4f13be92350c44060103; no voters: 
23:52:09.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.708612 29789 raft_consensus.cc:2804] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [term 1 FOLLOWER]: Leader election won for term 1
23:52:09.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.708891 29789 raft_consensus.cc:697] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [term 1 LEADER]: Becoming Leader. State: Replica: 3e46ae66aba04cb0b29ede3fb2950f89, State: Running, Role: LEADER
23:52:09.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.709471 29789 consensus_queue.cc:237] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [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: "9631a322f0ce4cbfb37664951d77e35d" member_type: VOTER last_known_addr { host: "127.28.98.1" port: 43657 } } peers { permanent_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" member_type: VOTER last_known_addr { host: "127.28.98.2" port: 35733 } } peers { permanent_uuid: "aa09f00db11e4f13be92350c44060103" member_type: VOTER last_known_addr { host: "127.28.98.3" port: 42363 } }
23:52:09.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.713824 29177 catalog_manager.cc:5696] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 reported cstate change: term changed from 0 to 1, leader changed from <none> to 3e46ae66aba04cb0b29ede3fb2950f89 (127.28.98.2). New cstate: current_term: 1 leader_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9631a322f0ce4cbfb37664951d77e35d" member_type: VOTER last_known_addr { host: "127.28.98.1" port: 43657 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "3e46ae66aba04cb0b29ede3fb2950f89" member_type: VOTER last_known_addr { host: "127.28.98.2" port: 35733 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "aa09f00db11e4f13be92350c44060103" member_type: VOTER last_known_addr { host: "127.28.98.3" port: 42363 } health_report { overall_health: UNKNOWN } } }
23:52:09.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:52:09.717754 29480 tablet.cc:2406] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:52:09.753 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet b72f65cc87e74f4193b82af8ef1f411e for table 'org.apache.kudu.client.TestHybridTime-1783468326531' with partition [<start>, <end>)
23:52:09.759 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=b72f65cc87e74f4193b82af8ef1f411e@[3e46ae66aba04cb0b29ede3fb2950f89(127.28.98.2:35733)[L],9631a322f0ce4cbfb37664951d77e35d(127.28.98.1:43657),aa09f00db11e4f13be92350c44060103(127.28.98.3:42363)]}]
23:52:09.760 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=17), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.28.98.61:40115, [8ms] Sub RPC GetTableLocations: received response from server master-127.28.98.61:40115: OK, deferred=null) after lookup
23:52:09.772 [DEBUG - kudu-nio-2] (Connection.java:748) [peer 3e46ae66aba04cb0b29ede3fb2950f89(127.28.98.2:35733)] connecting to peer
23:52:09.774 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 3e46ae66aba04cb0b29ede3fb2950f89(127.28.98.2:35733)] Successfully connected to peer
23:52:09.847 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x3774a899, L:/127.0.0.1:58280 - R:/127.28.98.2:35733] using TOKEN/null
23:52:09.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.854614 29430 raft_consensus.cc:1275] T b72f65cc87e74f4193b82af8ef1f411e P 9631a322f0ce4cbfb37664951d77e35d [term 1 FOLLOWER]: Refusing update from remote peer 3e46ae66aba04cb0b29ede3fb2950f89: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
23:52:09.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.854614 29706 raft_consensus.cc:1275] T b72f65cc87e74f4193b82af8ef1f411e P aa09f00db11e4f13be92350c44060103 [term 1 FOLLOWER]: Refusing update from remote peer 3e46ae66aba04cb0b29ede3fb2950f89: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
23:52:09.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.855444 29794 consensus_queue.cc:1048] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [LEADER]: Connected to new peer: Peer: permanent_uuid: "9631a322f0ce4cbfb37664951d77e35d" member_type: VOTER last_known_addr { host: "127.28.98.1" port: 43657 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:52:09.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.855916 29789 consensus_queue.cc:1048] T b72f65cc87e74f4193b82af8ef1f411e P 3e46ae66aba04cb0b29ede3fb2950f89 [LEADER]: Connected to new peer: Peer: permanent_uuid: "aa09f00db11e4f13be92350c44060103" member_type: VOTER last_known_addr { host: "127.28.98.3" port: 42363 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:52:09.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.867383 29800 mvcc.cc:204] Tried to move back new op lower bound from 7305086279075827712 to 7305086278493229056. Current Snapshot: MvccSnapshot[applied={T|T < 7305086279075827712}]
23:52:09.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:09.870599 29801 mvcc.cc:204] Tried to move back new op lower bound from 7305086279075827712 to 7305086278493229056. Current Snapshot: MvccSnapshot[applied={T|T < 7305086279075827712}]
23:52:09.912 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:52:09.934 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:52:09.942 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:52:09.954 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1513564973(state=PENDING, result=null, callback=<none>, errback=<none>)}
23:52:09.966 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:52:09.967 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@641200711(state=PENDING, result=null, callback=<none>, errback=<none>)}
23:52:09.975 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:52:09.976 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@311596120(state=PENDING, result=null, callback=<none>, errback=<none>)}
23:52:09.984 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:52:10.036 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783468326531, tablet=b72f65cc87e74f4193b82af8ef1f411e, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:52:10.043 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305086299555827713) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783468326531, tablet=b72f65cc87e74f4193b82af8ef1f411e, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:52:10.048 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305086299555827719) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783468326531, tablet=b72f65cc87e74f4193b82af8ef1f411e, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:52:10.053 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305086299555827723) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783468326531, tablet=b72f65cc87e74f4193b82af8ef1f411e, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:52:10.057 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305086299555827727) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783468326531, tablet=b72f65cc87e74f4193b82af8ef1f411e, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:52:10.062 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305086299555827731) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783468326531, tablet=b72f65cc87e74f4193b82af8ef1f411e, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:52:10.067 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305086299555827735) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783468326531, tablet=b72f65cc87e74f4193b82af8ef1f411e, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:52:10.072 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305086299555827736) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783468326531, tablet=b72f65cc87e74f4193b82af8ef1f411e, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:52:10.075 [DEBUG - main] (Connection.java:575) [peer master-127.28.98.62:39099(127.28.98.62:39099)] disconnecting while in state READY
23:52:10.076 [DEBUG - main] (Connection.java:575) [peer 3e46ae66aba04cb0b29ede3fb2950f89(127.28.98.2:35733)] disconnecting while in state READY
23:52:10.076 [DEBUG - main] (Connection.java:575) [peer master-127.28.98.61:40115(127.28.98.61:40115)] disconnecting while in state READY
23:52:10.076 [DEBUG - main] (Connection.java:575) [peer master-127.28.98.60:43863(127.28.98.60:43863)] disconnecting while in state READY
23:52:10.081 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2704) Releasing all remaining resources
23:52:10.081 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.28.98.61:40115(127.28.98.61:40115)] handling channelInactive
23:52:10.082 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.28.98.61:40115(127.28.98.61:40115)] cleaning up while in state READY due to: connection closed
23:52:10.083 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.28.98.60:43863(127.28.98.60:43863)] handling channelInactive
23:52:10.083 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.28.98.60:43863(127.28.98.60:43863)] cleaning up while in state READY due to: connection closed
23:52:10.083 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 3e46ae66aba04cb0b29ede3fb2950f89(127.28.98.2:35733)] handling channelInactive
23:52:10.083 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 3e46ae66aba04cb0b29ede3fb2950f89(127.28.98.2:35733)] cleaning up while in state READY due to: connection closed
23:52:10.090 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.28.98.62:39099(127.28.98.62:39099)] handling channelInactive
23:52:10.091 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.28.98.62:39099(127.28.98.62:39099)] cleaning up while in state READY due to: connection closed
23:52:10.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:10.090758 29064 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu with pid 29348
23:52:10.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:10.100692 29064 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu with pid 29487
23:52:10.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:10.108413 29064 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu with pid 29623
23:52:10.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:10.115561 29064 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu with pid 29075
23:52:10.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:10.123237 29064 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu with pid 29144
23:52:10.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:52:10.131008 29064 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOKr_xz/build/debug/bin/kudu with pid 29216
23:52:10.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:52:10Z chronyd exiting

Time: 3.563

OK (1 test)

