JUnit version 4.13.2
.12:09:14.114 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783512554104
12:09:14.143 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
12:09:14.181 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
12:09:14.194 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taski5ebua/test-tmp
12:09:14.217 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/asan/bin
12:09:14.220 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taski5ebua/java/build/dist-test/../../../build/asan/bin/kudu, test, mini_cluster, --serialization=pb]
12:09:14.395 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

12:09:14.594 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
12:09:14.596 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

12:09:14.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.598759 27208 mini_oidc.cc:150] Starting JWKS server
12:09:14.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.601212 27208 webserver.cc:533] Webserver started at http://127.0.0.1:36915/ using document root <none> and password file <none>
12:09:14.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.601492 27208 mini_oidc.cc:186] Starting OIDC Discovery server
12:09:14.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.602586 27208 webserver.cc:533] Webserver started at http://127.0.0.1:39745/ using document root <none> and password file <none>
12:09:14.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T12:09:14Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
12:09:14.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T12:09:14Z Disabled control of system clock
12:09:14.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.634117 27208 external_mini_cluster.cc:1372] Running /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:14.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:14.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/wal
12:09:14.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/data
12:09:14.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
12:09:14.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
12:09:14.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
12:09:14.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:14.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:14.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:14.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/logs
12:09:14.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/data/info.pb
12:09:14.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:14.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
12:09:14.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
12:09:14.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
12:09:14.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
12:09:14.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:14.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:14.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:14.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
12:09:14.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
12:09:14.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
12:09:14.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
12:09:14.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.62:37897
12:09:14.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.62
12:09:14.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:14.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:14.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:14.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:14.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
12:09:14.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
12:09:14.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:14.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
12:09:14.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36915/jwks.json with env {}
12:09:14.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.958904 27219 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
12:09:14.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.959273 27219 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
12:09:14.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.959390 27219 flags.cc:432] Enabled unsafe flag: --never_fsync=true
12:09:14.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.968274 27219 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
12:09:14.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.968396 27219 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
12:09:14.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.968478 27219 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
12:09:14.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.968535 27219 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
12:09:14.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.968609 27219 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
12:09:14.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.968668 27219 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36915/jwks.json
12:09:14.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.979091 27219 master_runner.cc:387] Master server non-default flags:
12:09:14.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:14.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:14.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:14.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
12:09:14.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/data
12:09:14.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/wal
12:09:14.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
12:09:14.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:14.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:14.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:14.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
12:09:14.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.62:37897
12:09:14.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
12:09:14.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
12:09:14.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
12:09:14.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36915/jwks.json
12:09:14.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:14.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:14.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/data/info.pb
12:09:14.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.62
12:09:14.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:14.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
12:09:14.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:14.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
12:09:14.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
12:09:14.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:14.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/logs
12:09:14.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:14.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
12:09:14.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
12:09:14.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
12:09:14.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
12:09:14.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 8aadabe0236da0a312e7e3764fada9dc81e70c40
12:09:14.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
12:09:14.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 11:49:08 UTC on bdcb31816ec0
12:09:14.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16856
12:09:14.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
12:09:14.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.981262 27219 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
12:09:14.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.983673 27219 file_cache.cc:492] Constructed file cache file cache with capacity 419430
12:09:14.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.993086 27224 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
12:09:14.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.993176 27225 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
12:09:14.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:14.994359 27227 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
12:09:14.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.994628 27219 server_base.cc:1061] running on GCE node
12:09:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.995500 27219 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
12:09:14.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.996940 27219 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
12:09:14.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.998174 27219 hybrid_clock.cc:648] HybridClock initialized: now 1783512554998114 us; error 43 us; skew 500 ppm
12:09:14.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:14.998607 27219 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
12:09:15.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.000767 27219 webserver.cc:533] Webserver started at http://127.26.146.62:40255/ using document root <none> and password file <none>
12:09:15.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.001586 27219 fs_manager.cc:362] Metadata directory not provided
12:09:15.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.001720 27219 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
12:09:15.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.002156 27219 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
12:09:15.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.004587 27219 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/data/instance:
12:09:15.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "247c860819954c4b957b85075d339fe9"
12:09:15.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:14 on dist-test-slave-1ld0"
12:09:15.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.005916 27219 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/wal/instance:
12:09:15.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "247c860819954c4b957b85075d339fe9"
12:09:15.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:14 on dist-test-slave-1ld0"
12:09:15.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.011301 27219 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.006s	sys 0.002s
12:09:15.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.014806 27233 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
12:09:15.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.016227 27219 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.001s
12:09:15.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.016417 27219 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/data,/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/wal
12:09:15.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "247c860819954c4b957b85075d339fe9"
12:09:15.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:14 on dist-test-slave-1ld0"
12:09:15.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.016669 27219 fs_report.cc:389] FS layout report
12:09:15.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
12:09:15.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/wal
12:09:15.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/wal
12:09:15.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/data/data
12:09:15.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
12:09:15.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
12:09:15.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
12:09:15.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
12:09:15.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
12:09:15.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
12:09:15.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
12:09:15.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
12:09:15.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
12:09:15.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
12:09:15.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
12:09:15.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.040491 27219 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
12:09:15.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.041528 27219 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
12:09:15.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.041870 27219 kserver.cc:163] Server-wide thread pool size limit: 3276
12:09:15.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.062865 27219 rpc_server.cc:307] RPC server started. Bound to: 127.26.146.62:37897
12:09:15.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.062901 27284 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.146.62:37897 every 8 connection(s)
12:09:15.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.064567 27219 server_base.cc:1193] Dumped server information to /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/data/info.pb
12:09:15.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.066262 27208 external_mini_cluster.cc:1434] Started /tmp/dist-test-taski5ebua/build/asan/bin/kudu as pid 27219
12:09:15.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.066587 27208 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-0/wal/instance
12:09:15.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.069284 27208 external_mini_cluster.cc:1372] Running /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:15.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:15.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/wal
12:09:15.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/data
12:09:15.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
12:09:15.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
12:09:15.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
12:09:15.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:15.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:15.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:15.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/logs
12:09:15.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/data/info.pb
12:09:15.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:15.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
12:09:15.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
12:09:15.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
12:09:15.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
12:09:15.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:15.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:15.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:15.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
12:09:15.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
12:09:15.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
12:09:15.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
12:09:15.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.61:36791
12:09:15.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.61
12:09:15.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:15.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:15.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:15.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:15.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
12:09:15.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
12:09:15.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:15.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
12:09:15.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36915/jwks.json with env {}
12:09:15.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.069314 27285 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
12:09:15.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.075969 27285 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } has no permanent_uuid. Determining permanent_uuid...
12:09:15.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.092005 27285 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } has no permanent_uuid. Determining permanent_uuid...
12:09:15.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.093143 27236 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.26.146.61:36791: connect: Connection refused (error 111)
12:09:15.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.094736 27285 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.61:36791: Network error: Client connection negotiation failed: client connection to 127.26.146.61:36791: connect: Connection refused (error 111)
12:09:15.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.144366 27285 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } attempt: 1
12:09:15.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.146576 27285 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.61:36791: Network error: Client connection negotiation failed: client connection to 127.26.146.61:36791: connect: Connection refused (error 111)
12:09:15.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.214828 27285 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } attempt: 2
12:09:15.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.217363 27285 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.61:36791: Network error: Client connection negotiation failed: client connection to 127.26.146.61:36791: connect: Connection refused (error 111)
12:09:15.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.308638 27285 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } attempt: 3
12:09:15.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.310915 27285 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.61:36791: Network error: Client connection negotiation failed: client connection to 127.26.146.61:36791: connect: Connection refused (error 111)
12:09:15.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.412837 27287 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
12:09:15.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.413174 27287 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
12:09:15.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.413281 27287 flags.cc:432] Enabled unsafe flag: --never_fsync=true
12:09:15.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.421679 27287 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
12:09:15.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.421809 27287 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
12:09:15.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.421895 27287 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
12:09:15.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.421957 27287 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
12:09:15.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.422474 27287 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
12:09:15.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.422549 27287 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36915/jwks.json
12:09:15.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.432910 27287 master_runner.cc:387] Master server non-default flags:
12:09:15.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:15.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:15.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:15.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
12:09:15.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/data
12:09:15.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/wal
12:09:15.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
12:09:15.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:15.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:15.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:15.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
12:09:15.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.61:36791
12:09:15.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
12:09:15.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
12:09:15.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
12:09:15.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36915/jwks.json
12:09:15.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:15.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:15.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/data/info.pb
12:09:15.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.61
12:09:15.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:15.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
12:09:15.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:15.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
12:09:15.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
12:09:15.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:15.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/logs
12:09:15.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:15.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
12:09:15.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
12:09:15.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
12:09:15.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
12:09:15.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 8aadabe0236da0a312e7e3764fada9dc81e70c40
12:09:15.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
12:09:15.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 11:49:08 UTC on bdcb31816ec0
12:09:15.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16856
12:09:15.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
12:09:15.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.435236 27287 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
12:09:15.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.437831 27287 file_cache.cc:492] Constructed file cache file cache with capacity 419430
12:09:15.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.446494 27295 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
12:09:15.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.447160 27296 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
12:09:15.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.450241 27298 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
12:09:15.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.451020 27287 server_base.cc:1061] running on GCE node
12:09:15.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.451887 27287 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
12:09:15.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.453353 27287 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
12:09:15.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.454152 27285 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } attempt: 4
12:09:15.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.454569 27287 hybrid_clock.cc:648] HybridClock initialized: now 1783512555454526 us; error 32 us; skew 500 ppm
12:09:15.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.454849 27287 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
12:09:15.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.456136 27285 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.61:36791: Network error: Client connection negotiation failed: client connection to 127.26.146.61:36791: connect: Connection refused (error 111)
12:09:15.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.457273 27287 webserver.cc:533] Webserver started at http://127.26.146.61:37361/ using document root <none> and password file <none>
12:09:15.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.458214 27287 fs_manager.cc:362] Metadata directory not provided
12:09:15.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.458386 27287 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
12:09:15.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.458818 27287 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
12:09:15.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.461477 27287 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/data/instance:
12:09:15.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cdbb70c1d4f141ee972811af5a1e0637"
12:09:15.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:15 on dist-test-slave-1ld0"
12:09:15.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.462430 27287 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/wal/instance:
12:09:15.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cdbb70c1d4f141ee972811af5a1e0637"
12:09:15.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:15 on dist-test-slave-1ld0"
12:09:15.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.468186 27287 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.003s	sys 0.002s
12:09:15.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.471560 27304 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
12:09:15.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.472823 27287 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
12:09:15.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.473001 27287 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/data,/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/wal
12:09:15.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cdbb70c1d4f141ee972811af5a1e0637"
12:09:15.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:15 on dist-test-slave-1ld0"
12:09:15.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.473239 27287 fs_report.cc:389] FS layout report
12:09:15.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
12:09:15.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/wal
12:09:15.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/wal
12:09:15.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/data/data
12:09:15.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
12:09:15.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
12:09:15.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
12:09:15.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
12:09:15.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
12:09:15.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
12:09:15.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
12:09:15.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
12:09:15.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
12:09:15.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
12:09:15.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
12:09:15.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.490024 27287 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
12:09:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.490945 27287 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
12:09:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.491263 27287 kserver.cc:163] Server-wide thread pool size limit: 3276
12:09:15.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.511780 27287 rpc_server.cc:307] RPC server started. Bound to: 127.26.146.61:36791
12:09:15.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.511854 27355 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.146.61:36791 every 8 connection(s)
12:09:15.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.513362 27287 server_base.cc:1193] Dumped server information to /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/data/info.pb
12:09:15.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.516111 27208 external_mini_cluster.cc:1434] Started /tmp/dist-test-taski5ebua/build/asan/bin/kudu as pid 27287
12:09:15.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.516289 27208 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-1/wal/instance
12:09:15.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.517280 27208 external_mini_cluster.cc:1372] Running /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:15.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:15.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/wal
12:09:15.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/data
12:09:15.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
12:09:15.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
12:09:15.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
12:09:15.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:15.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:15.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:15.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/logs
12:09:15.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/data/info.pb
12:09:15.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:15.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
12:09:15.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
12:09:15.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
12:09:15.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
12:09:15.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:15.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:15.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:15.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
12:09:15.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
12:09:15.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
12:09:15.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
12:09:15.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.60:38097
12:09:15.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.60
12:09:15.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:15.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:15.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:15.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:15.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
12:09:15.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
12:09:15.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:15.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
12:09:15.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36915/jwks.json with env {}
12:09:15.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.517427 27356 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
12:09:15.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.526273 27356 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } has no permanent_uuid. Determining permanent_uuid...
12:09:15.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.541438 27356 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } has no permanent_uuid. Determining permanent_uuid...
12:09:15.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.550648 27356 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } has no permanent_uuid. Determining permanent_uuid...
12:09:15.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.551818 27305 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.26.146.60:38097: connect: Connection refused (error 111)
12:09:15.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.553566 27356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.60:38097: Network error: Client connection negotiation failed: client connection to 127.26.146.60:38097: connect: Connection refused (error 111)
12:09:15.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.602891 27356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } attempt: 1
12:09:15.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.605093 27356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.60:38097: Network error: Client connection negotiation failed: client connection to 127.26.146.60:38097: connect: Connection refused (error 111)
12:09:15.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.673336 27356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } attempt: 2
12:09:15.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.675650 27356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.60:38097: Network error: Client connection negotiation failed: client connection to 127.26.146.60:38097: connect: Connection refused (error 111)
12:09:15.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.755498 27285 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } attempt: 5
12:09:15.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.763900 27285 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } has no permanent_uuid. Determining permanent_uuid...
12:09:15.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.767064 27285 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.60:38097: Network error: Client connection negotiation failed: client connection to 127.26.146.60:38097: connect: Connection refused (error 111)
12:09:15.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.767006 27356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } attempt: 3
12:09:15.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.769450 27356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.60:38097: Network error: Client connection negotiation failed: client connection to 127.26.146.60:38097: connect: Connection refused (error 111)
12:09:15.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.818315 27285 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } attempt: 1
12:09:15.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.820580 27285 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.60:38097: Network error: Client connection negotiation failed: client connection to 127.26.146.60:38097: connect: Connection refused (error 111)
12:09:15.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.888857 27285 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } attempt: 2
12:09:15.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.891496 27285 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.60:38097: Network error: Client connection negotiation failed: client connection to 127.26.146.60:38097: connect: Connection refused (error 111)
12:09:15.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.912704 27356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } attempt: 4
12:09:15.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:15.915258 27356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.60:38097: Network error: Client connection negotiation failed: client connection to 127.26.146.60:38097: connect: Connection refused (error 111)
12:09:15.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:15.997785 27285 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } attempt: 3
12:09:16.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.000268 27285 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.146.60:38097: Network error: Client connection negotiation failed: client connection to 127.26.146.60:38097: connect: Connection refused (error 111)
12:09:16.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.028350 27358 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
12:09:16.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.028724 27358 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
12:09:16.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.028842 27358 flags.cc:432] Enabled unsafe flag: --never_fsync=true
12:09:16.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.040190 27358 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
12:09:16.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.040303 27358 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
12:09:16.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.040416 27358 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
12:09:16.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.040500 27358 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
12:09:16.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.040606 27358 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
12:09:16.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.040671 27358 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36915/jwks.json
12:09:16.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.058661 27358 master_runner.cc:387] Master server non-default flags:
12:09:16.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:16.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:16.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:16.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
12:09:16.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/data
12:09:16.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/wal
12:09:16.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
12:09:16.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:16.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:16.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:16.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
12:09:16.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.60:38097
12:09:16.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
12:09:16.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
12:09:16.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
12:09:16.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36915/jwks.json
12:09:16.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:16.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:16.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/data/info.pb
12:09:16.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.60
12:09:16.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:16.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
12:09:16.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:16.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
12:09:16.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
12:09:16.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:16.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/logs
12:09:16.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:16.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
12:09:16.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
12:09:16.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
12:09:16.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
12:09:16.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 8aadabe0236da0a312e7e3764fada9dc81e70c40
12:09:16.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
12:09:16.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 11:49:08 UTC on bdcb31816ec0
12:09:16.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16856
12:09:16.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
12:09:16.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.060792 27358 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
12:09:16.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.063678 27358 file_cache.cc:492] Constructed file cache file cache with capacity 419430
12:09:16.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.075501 27366 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
12:09:16.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.077446 27367 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
12:09:16.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.080171 27369 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
12:09:16.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.080662 27358 server_base.cc:1061] running on GCE node
12:09:16.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.081604 27358 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
12:09:16.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.083205 27358 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
12:09:16.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.084457 27358 hybrid_clock.cc:648] HybridClock initialized: now 1783512556084378 us; error 47 us; skew 500 ppm
12:09:16.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.084864 27358 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
12:09:16.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.087922 27358 webserver.cc:533] Webserver started at http://127.26.146.60:38685/ using document root <none> and password file <none>
12:09:16.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.088706 27358 fs_manager.cc:362] Metadata directory not provided
12:09:16.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.088882 27358 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
12:09:16.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.089249 27358 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
12:09:16.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.091993 27358 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/data/instance:
12:09:16.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e7753e172baa4feba63a9ba7a505a64b"
12:09:16.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:16 on dist-test-slave-1ld0"
12:09:16.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.092983 27358 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/wal/instance:
12:09:16.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e7753e172baa4feba63a9ba7a505a64b"
12:09:16.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:16 on dist-test-slave-1ld0"
12:09:16.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.099793 27358 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.002s	sys 0.006s
12:09:16.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.104851 27375 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
12:09:16.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.106791 27358 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.001s
12:09:16.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.107053 27358 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/data,/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/wal
12:09:16.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e7753e172baa4feba63a9ba7a505a64b"
12:09:16.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:16 on dist-test-slave-1ld0"
12:09:16.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.107419 27358 fs_report.cc:389] FS layout report
12:09:16.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
12:09:16.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/wal
12:09:16.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/wal
12:09:16.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/data/data
12:09:16.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
12:09:16.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
12:09:16.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
12:09:16.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
12:09:16.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
12:09:16.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
12:09:16.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
12:09:16.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
12:09:16.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
12:09:16.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
12:09:16.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
12:09:16.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.129581 27358 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
12:09:16.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.130949 27358 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
12:09:16.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.131330 27358 kserver.cc:163] Server-wide thread pool size limit: 3276
12:09:16.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.166479 27426 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.146.60:38097 every 8 connection(s)
12:09:16.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.166555 27358 rpc_server.cc:307] RPC server started. Bound to: 127.26.146.60:38097
12:09:16.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.168246 27358 server_base.cc:1193] Dumped server information to /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/data/info.pb
12:09:16.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.172477 27427 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
12:09:16.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.172488 27208 external_mini_cluster.cc:1434] Started /tmp/dist-test-taski5ebua/build/asan/bin/kudu as pid 27358
12:09:16.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.172655 27208 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/master-2/wal/instance
12:09:16.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.177481 27285 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } attempt: 4
12:09:16.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.182767 27427 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } has no permanent_uuid. Determining permanent_uuid...
12:09:16.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.206362 27427 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } has no permanent_uuid. Determining permanent_uuid...
12:09:16.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.212863 27285 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9: Bootstrap starting.
12:09:16.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.214150 27427 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } has no permanent_uuid. Determining permanent_uuid...
12:09:16.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.214488 27356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } attempt: 5
12:09:16.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.217307 27285 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9: Neither blocks nor log segments found. Creating new log.
12:09:16.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.218685 27285 log.cc:826] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9: Log is configured to *not* fsync() on all Append() calls
12:09:16.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.227512 27427 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b: Bootstrap starting.
12:09:16.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.227512 27356 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637: Bootstrap starting.
12:09:16.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.228044 27285 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9: No bootstrap required, opened a new log
12:09:16.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.231329 27356 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637: Neither blocks nor log segments found. Creating new log.
12:09:16.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.231329 27427 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b: Neither blocks nor log segments found. Creating new log.
12:09:16.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.232605 27427 log.cc:826] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b: Log is configured to *not* fsync() on all Append() calls
12:09:16.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.232609 27356 log.cc:826] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637: Log is configured to *not* fsync() on all Append() calls
12:09:16.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.234397 27285 raft_consensus.cc:359] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } }
12:09:16.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.235122 27285 raft_consensus.cc:385] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
12:09:16.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.235680 27285 raft_consensus.cc:740] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 247c860819954c4b957b85075d339fe9, State: Initialized, Role: FOLLOWER
12:09:16.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.236397 27285 consensus_queue.cc:260] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [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: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } }
12:09:16.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.237280 27427 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b: No bootstrap required, opened a new log
12:09:16.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.237280 27356 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637: No bootstrap required, opened a new log
12:09:16.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.237445 27438 sys_catalog.cc:455] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [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: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } } }
12:09:16.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.237756 27438 sys_catalog.cc:458] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [sys.catalog]: This master's current role is: FOLLOWER
12:09:16.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.238772 27285 sys_catalog.cc:565] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [sys.catalog]: configured and running, proceeding with master startup.
12:09:16.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.244630 27356 raft_consensus.cc:359] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } }
12:09:16.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.245332 27356 raft_consensus.cc:385] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
12:09:16.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.245507 27356 raft_consensus.cc:740] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: cdbb70c1d4f141ee972811af5a1e0637, State: Initialized, Role: FOLLOWER
12:09:16.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.246204 27356 consensus_queue.cc:260] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [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: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } }
12:09:16.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.246174 27427 raft_consensus.cc:359] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } }
12:09:16.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.246618 27427 raft_consensus.cc:385] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
12:09:16.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.246752 27427 raft_consensus.cc:740] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e7753e172baa4feba63a9ba7a505a64b, State: Initialized, Role: FOLLOWER
12:09:16.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.247918 27427 consensus_queue.cc:260] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [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: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } }
12:09:16.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.250788 27438 raft_consensus.cc:493] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
12:09:16.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.251137 27438 raft_consensus.cc:515] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } }
12:09:16.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.251950 27356 sys_catalog.cc:565] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [sys.catalog]: configured and running, proceeding with master startup.
12:09:16.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.249291 27451 sys_catalog.cc:455] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [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: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } } }
12:09:16.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.253448 27451 sys_catalog.cc:458] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [sys.catalog]: This master's current role is: FOLLOWER
12:09:16.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.250620 27427 sys_catalog.cc:565] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [sys.catalog]: configured and running, proceeding with master startup.
12:09:16.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.254616 27450 sys_catalog.cc:455] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [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: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } } }
12:09:16.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.255267 27450 sys_catalog.cc:458] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [sys.catalog]: This master's current role is: FOLLOWER
12:09:16.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.256561 27331 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "247c860819954c4b957b85075d339fe9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "cdbb70c1d4f141ee972811af5a1e0637" is_pre_election: true
12:09:16.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.257123 27331 raft_consensus.cc:2468] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 247c860819954c4b957b85075d339fe9 in term 0.
12:09:16.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.257421 27401 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "247c860819954c4b957b85075d339fe9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e7753e172baa4feba63a9ba7a505a64b" is_pre_election: true
12:09:16.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.258204 27401 raft_consensus.cc:2468] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 247c860819954c4b957b85075d339fe9 in term 0.
12:09:16.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.256150 27449 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
12:09:16.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.258175 27236 leader_election.cc:304] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [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: 247c860819954c4b957b85075d339fe9, cdbb70c1d4f141ee972811af5a1e0637; no voters: 
12:09:16.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.256443 27438 leader_election.cc:290] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers cdbb70c1d4f141ee972811af5a1e0637 (127.26.146.61:36791), e7753e172baa4feba63a9ba7a505a64b (127.26.146.60:38097)
12:09:16.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.266093 27438 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [term 0 FOLLOWER]: Leader pre-election won for term 1
12:09:16.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.266853 27438 raft_consensus.cc:493] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
12:09:16.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.267472 27438 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [term 0 FOLLOWER]: Advancing to term 1
12:09:16.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.276067 27438 raft_consensus.cc:515] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } }
12:09:16.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.281143 27438 leader_election.cc:290] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [CANDIDATE]: Term 1 election: Requested vote from peers cdbb70c1d4f141ee972811af5a1e0637 (127.26.146.61:36791), e7753e172baa4feba63a9ba7a505a64b (127.26.146.60:38097)
12:09:16.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.282802 27401 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "247c860819954c4b957b85075d339fe9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e7753e172baa4feba63a9ba7a505a64b"
12:09:16.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.282907 27331 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "247c860819954c4b957b85075d339fe9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "cdbb70c1d4f141ee972811af5a1e0637"
12:09:16.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.283015 27401 raft_consensus.cc:3060] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [term 0 FOLLOWER]: Advancing to term 1
12:09:16.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.283085 27331 raft_consensus.cc:3060] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [term 0 FOLLOWER]: Advancing to term 1
12:09:16.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.286183 27401 raft_consensus.cc:2468] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 247c860819954c4b957b85075d339fe9 in term 1.
12:09:16.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.286190 27331 raft_consensus.cc:2468] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 247c860819954c4b957b85075d339fe9 in term 1.
12:09:16.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.286676 27234 leader_election.cc:304] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [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: 247c860819954c4b957b85075d339fe9, cdbb70c1d4f141ee972811af5a1e0637, e7753e172baa4feba63a9ba7a505a64b; no voters: 
12:09:16.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.287477 27438 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [term 1 FOLLOWER]: Leader election won for term 1
12:09:16.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.287631 27438 raft_consensus.cc:697] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [term 1 LEADER]: Becoming Leader. State: Replica: 247c860819954c4b957b85075d339fe9, State: Running, Role: LEADER
12:09:16.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.288143 27438 consensus_queue.cc:237] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [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: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } }
12:09:16.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.279605 27219 master_runner.cc:187] Error getting master registration for 127.26.146.61:36791: OK, instance_id { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" instance_seqno: 1783512555506424 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
12:09:16.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.291898 27219 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
12:09:16.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.294608 27239 tablet.cc:2406] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9: Can't schedule compaction. Clean time has not been advanced past its initial value.
12:09:16.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.303399 27454 sys_catalog.cc:455] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 247c860819954c4b957b85075d339fe9. Latest consensus state: current_term: 1 leader_uuid: "247c860819954c4b957b85075d339fe9" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } } }
12:09:16.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.303699 27454 sys_catalog.cc:458] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [sys.catalog]: This master's current role is: LEADER
12:09:16.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.305213 27465 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
12:09:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.317912 27465 catalog_manager.cc:1520] Initializing Kudu cluster ID...
12:09:16.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.345098 27401 raft_consensus.cc:1275] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [term 1 FOLLOWER]: Refusing update from remote peer 247c860819954c4b957b85075d339fe9: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
12:09:16.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.346837 27454 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [LEADER]: Connected to new peer: Peer: permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
12:09:16.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.355233 27331 raft_consensus.cc:1275] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [term 1 FOLLOWER]: Refusing update from remote peer 247c860819954c4b957b85075d339fe9: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
12:09:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.356236 27454 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [LEADER]: Connected to new peer: Peer: permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
12:09:16.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.377599 27451 sys_catalog.cc:455] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [sys.catalog]: SysCatalogTable state changed. Reason: New leader 247c860819954c4b957b85075d339fe9. Latest consensus state: current_term: 1 leader_uuid: "247c860819954c4b957b85075d339fe9" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } } }
12:09:16.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.377969 27451 sys_catalog.cc:458] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [sys.catalog]: This master's current role is: FOLLOWER
12:09:16.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.379254 27482 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
12:09:16.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.382539 27450 sys_catalog.cc:455] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 247c860819954c4b957b85075d339fe9. Latest consensus state: current_term: 1 leader_uuid: "247c860819954c4b957b85075d339fe9" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } } }
12:09:16.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.382783 27450 sys_catalog.cc:458] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [sys.catalog]: This master's current role is: FOLLOWER
12:09:16.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.384457 27381 tablet.cc:2406] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b: Can't schedule compaction. Clean time has not been advanced past its initial value.
12:09:16.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.387267 27476 mvcc.cc:204] Tried to move back new op lower bound from 7305267430773440512 to 7305267430560784384. Current Snapshot: MvccSnapshot[applied={T|T < 7305267430773440512}]
12:09:16.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.390930 27477 catalog_manager.cc:1594] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
12:09:16.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.395188 27477 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
12:09:16.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.395984 27471 mvcc.cc:204] Tried to move back new op lower bound from 7305267430773440512 to 7305267430560784384. Current Snapshot: MvccSnapshot[applied={T|T < 7305267430773440512}]
12:09:16.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.415921 27451 sys_catalog.cc:455] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "247c860819954c4b957b85075d339fe9" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } } }
12:09:16.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.416183 27451 sys_catalog.cc:458] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b [sys.catalog]: This master's current role is: FOLLOWER
12:09:16.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.423133 27454 sys_catalog.cc:455] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "247c860819954c4b957b85075d339fe9" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } } }
12:09:16.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.423643 27454 sys_catalog.cc:458] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [sys.catalog]: This master's current role is: LEADER
12:09:16.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.427042 27465 catalog_manager.cc:1383] Generated new cluster ID: 3f353d8b699943bc807c3b4c48f43d50
12:09:16.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.427165 27465 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
12:09:16.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.427744 27454 sys_catalog.cc:455] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "247c860819954c4b957b85075d339fe9" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } } }
12:09:16.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.427924 27454 sys_catalog.cc:458] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9 [sys.catalog]: This master's current role is: LEADER
12:09:16.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.429340 27450 sys_catalog.cc:455] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "247c860819954c4b957b85075d339fe9" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "247c860819954c4b957b85075d339fe9" member_type: VOTER last_known_addr { host: "127.26.146.62" port: 37897 } } peers { permanent_uuid: "cdbb70c1d4f141ee972811af5a1e0637" member_type: VOTER last_known_addr { host: "127.26.146.61" port: 36791 } } peers { permanent_uuid: "e7753e172baa4feba63a9ba7a505a64b" member_type: VOTER last_known_addr { host: "127.26.146.60" port: 38097 } } }
12:09:16.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.429518 27450 sys_catalog.cc:458] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637 [sys.catalog]: This master's current role is: FOLLOWER
12:09:16.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.448379 27465 catalog_manager.cc:1406] Generated new certificate authority record
12:09:16.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.450268 27465 catalog_manager.cc:1540] Loading token signing keys...
12:09:16.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.469769 27465 catalog_manager.cc:6070] T 00000000000000000000000000000000 P 247c860819954c4b957b85075d339fe9: Generated new TSK 0
12:09:16.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.471241 27465 catalog_manager.cc:1550] Initializing in-progress tserver states...
12:09:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.490882 27208 external_mini_cluster.cc:1372] Running /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/wal
12:09:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/data
12:09:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
12:09:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
12:09:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
12:09:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/logs
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/data/info.pb
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:16.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
12:09:16.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
12:09:16.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.1:0
12:09:16.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.146.1
12:09:16.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.1
12:09:16.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:16.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:16.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:16.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:16.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:16.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
12:09:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.955577 27488 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
12:09:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.955847 27488 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
12:09:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.955922 27488 flags.cc:432] Enabled unsafe flag: --never_fsync=true
12:09:16.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.964609 27488 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
12:09:16.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.964772 27488 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.146.1
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.974789 27488 tablet_server_runner.cc:78] Tablet server non-default flags:
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/data
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/wal
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.1:0
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/data/info.pb
12:09:16.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.1
12:09:16.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:16.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:16.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
12:09:16.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:16.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
12:09:16.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
12:09:16.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:16.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.146.1
12:09:16.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/logs
12:09:16.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:16.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
12:09:16.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
12:09:16.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
12:09:16.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
12:09:16.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 8aadabe0236da0a312e7e3764fada9dc81e70c40
12:09:16.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
12:09:16.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 11:49:08 UTC on bdcb31816ec0
12:09:16.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16856
12:09:16.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
12:09:16.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.976368 27488 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
12:09:16.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.978560 27488 file_cache.cc:492] Constructed file cache file cache with capacity 419430
12:09:16.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.987581 27494 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
12:09:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.988713 27495 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
12:09:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:16.990127 27497 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
12:09:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.990775 27488 server_base.cc:1061] running on GCE node
12:09:16.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.991432 27488 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
12:09:16.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.992452 27488 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
12:09:16.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.993686 27488 hybrid_clock.cc:648] HybridClock initialized: now 1783512556993615 us; error 55 us; skew 500 ppm
12:09:16.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.994021 27488 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
12:09:16.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.996310 27488 webserver.cc:533] Webserver started at http://127.26.146.1:36827/ using document root <none> and password file <none>
12:09:16.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.997023 27488 fs_manager.cc:362] Metadata directory not provided
12:09:16.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.997152 27488 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
12:09:16.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.997579 27488 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
12:09:17.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:16.999909 27488 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/data/instance:
12:09:17.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "86d2e94781964fb5bce88aee72827e05"
12:09:17.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:16 on dist-test-slave-1ld0"
12:09:17.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.000782 27488 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/wal/instance:
12:09:17.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "86d2e94781964fb5bce88aee72827e05"
12:09:17.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:16 on dist-test-slave-1ld0"
12:09:17.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.006716 27488 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.006s	sys 0.001s
12:09:17.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.010016 27503 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
12:09:17.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.011631 27488 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
12:09:17.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.011762 27488 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/data,/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/wal
12:09:17.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "86d2e94781964fb5bce88aee72827e05"
12:09:17.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:16 on dist-test-slave-1ld0"
12:09:17.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.011952 27488 fs_report.cc:389] FS layout report
12:09:17.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
12:09:17.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/wal
12:09:17.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/wal
12:09:17.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/data/data
12:09:17.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
12:09:17.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
12:09:17.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
12:09:17.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
12:09:17.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
12:09:17.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
12:09:17.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
12:09:17.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
12:09:17.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
12:09:17.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
12:09:17.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
12:09:17.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.041201 27488 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
12:09:17.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.042045 27488 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
12:09:17.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.042273 27488 kserver.cc:163] Server-wide thread pool size limit: 3276
12:09:17.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.043363 27488 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
12:09:17.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.044987 27488 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
12:09:17.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.045069 27488 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
12:09:17.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.045135 27488 ts_tablet_manager.cc:616] Registered 0 tablets
12:09:17.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.045181 27488 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
12:09:17.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.082099 27488 rpc_server.cc:307] RPC server started. Bound to: 127.26.146.1:40001
12:09:17.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.082132 27615 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.146.1:40001 every 8 connection(s)
12:09:17.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.083894 27488 server_base.cc:1193] Dumped server information to /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/data/info.pb
12:09:17.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.084440 27208 external_mini_cluster.cc:1434] Started /tmp/dist-test-taski5ebua/build/asan/bin/kudu as pid 27488
12:09:17.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.084640 27208 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-0/wal/instance
12:09:17.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.092342 27208 external_mini_cluster.cc:1372] Running /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:17.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:17.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/wal
12:09:17.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/data
12:09:17.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/logs
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/data/info.pb
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
12:09:17.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
12:09:17.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:17.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:17.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:17.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
12:09:17.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
12:09:17.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.2:0
12:09:17.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.146.2
12:09:17.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.2
12:09:17.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:17.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:17.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:17.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:17.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:17.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
12:09:17.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.118315 27616 heartbeater.cc:344] Connected to a master server at 127.26.146.60:38097
12:09:17.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.118801 27616 heartbeater.cc:461] Registering TS with master...
12:09:17.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.120028 27616 heartbeater.cc:507] Master 127.26.146.60:38097 requested a full tablet report, sending...
12:09:17.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.123227 27391 ts_manager.cc:194] Registered new tserver with Master: 86d2e94781964fb5bce88aee72827e05 (127.26.146.1:40001)
12:09:17.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.129397 27621 heartbeater.cc:344] Connected to a master server at 127.26.146.61:36791
12:09:17.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.129581 27621 heartbeater.cc:461] Registering TS with master...
12:09:17.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.130201 27621 heartbeater.cc:507] Master 127.26.146.61:36791 requested a full tablet report, sending...
12:09:17.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.132292 27321 ts_manager.cc:194] Registered new tserver with Master: 86d2e94781964fb5bce88aee72827e05 (127.26.146.1:40001)
12:09:17.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.142777 27617 heartbeater.cc:344] Connected to a master server at 127.26.146.62:37897
12:09:17.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.142942 27617 heartbeater.cc:461] Registering TS with master...
12:09:17.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.143409 27617 heartbeater.cc:507] Master 127.26.146.62:37897 requested a full tablet report, sending...
12:09:17.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.144845 27250 ts_manager.cc:194] Registered new tserver with Master: 86d2e94781964fb5bce88aee72827e05 (127.26.146.1:40001)
12:09:17.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.146284 27250 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.26.146.1:47903
12:09:17.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.389200 27482 catalog_manager.cc:1295] Loaded cluster ID: 3f353d8b699943bc807c3b4c48f43d50
12:09:17.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.389350 27482 catalog_manager.cc:1588] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b: loading cluster ID for follower catalog manager: success
12:09:17.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.392391 27482 catalog_manager.cc:1610] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b: acquiring CA information for follower catalog manager: success
12:09:17.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.394271 27482 catalog_manager.cc:1638] T 00000000000000000000000000000000 P e7753e172baa4feba63a9ba7a505a64b: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
12:09:17.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.397518 27477 catalog_manager.cc:1295] Loaded cluster ID: 3f353d8b699943bc807c3b4c48f43d50
12:09:17.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.397639 27477 catalog_manager.cc:1588] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637: loading cluster ID for follower catalog manager: success
12:09:17.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.400169 27477 catalog_manager.cc:1610] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637: acquiring CA information for follower catalog manager: success
12:09:17.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.401872 27477 catalog_manager.cc:1638] T 00000000000000000000000000000000 P cdbb70c1d4f141ee972811af5a1e0637: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
12:09:17.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.473860 27620 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
12:09:17.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.474642 27620 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
12:09:17.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.474773 27620 flags.cc:432] Enabled unsafe flag: --never_fsync=true
12:09:17.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.483291 27620 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
12:09:17.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.483500 27620 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.146.2
12:09:17.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.493348 27620 tablet_server_runner.cc:78] Tablet server non-default flags:
12:09:17.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:17.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/data
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/wal
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.2:0
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/data/info.pb
12:09:17.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.2
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.146.2
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/logs
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
12:09:17.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
12:09:17.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
12:09:17.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 8aadabe0236da0a312e7e3764fada9dc81e70c40
12:09:17.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
12:09:17.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 11:49:08 UTC on bdcb31816ec0
12:09:17.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16856
12:09:17.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
12:09:17.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.495728 27620 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
12:09:17.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.497866 27620 file_cache.cc:492] Constructed file cache file cache with capacity 419430
12:09:17.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.508540 27633 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
12:09:17.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.508571 27632 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
12:09:17.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.510008 27635 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
12:09:17.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.511662 27620 server_base.cc:1061] running on GCE node
12:09:17.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.512337 27620 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
12:09:17.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.521839 27620 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
12:09:17.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.523447 27620 hybrid_clock.cc:648] HybridClock initialized: now 1783512557523343 us; error 93 us; skew 500 ppm
12:09:17.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.523839 27620 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
12:09:17.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.525974 27620 webserver.cc:533] Webserver started at http://127.26.146.2:40151/ using document root <none> and password file <none>
12:09:17.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.526916 27620 fs_manager.cc:362] Metadata directory not provided
12:09:17.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.527050 27620 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
12:09:17.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.527478 27620 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
12:09:17.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.529752 27620 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/data/instance:
12:09:17.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "910b9dd2497c48a49f3a734383328b5f"
12:09:17.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:17 on dist-test-slave-1ld0"
12:09:17.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.530652 27620 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/wal/instance:
12:09:17.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "910b9dd2497c48a49f3a734383328b5f"
12:09:17.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:17 on dist-test-slave-1ld0"
12:09:17.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.535799 27620 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.004s	sys 0.000s
12:09:17.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.539662 27641 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
12:09:17.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.541102 27620 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.003s
12:09:17.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.541275 27620 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/data,/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/wal
12:09:17.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "910b9dd2497c48a49f3a734383328b5f"
12:09:17.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:17 on dist-test-slave-1ld0"
12:09:17.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.541525 27620 fs_report.cc:389] FS layout report
12:09:17.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
12:09:17.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/wal
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/wal
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/data/data
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
12:09:17.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
12:09:17.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.562565 27620 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
12:09:17.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.563809 27620 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
12:09:17.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.564119 27620 kserver.cc:163] Server-wide thread pool size limit: 3276
12:09:17.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.565316 27620 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
12:09:17.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.566989 27620 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
12:09:17.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.567106 27620 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
12:09:17.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.567198 27620 ts_tablet_manager.cc:616] Registered 0 tablets
12:09:17.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.567272 27620 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
12:09:17.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.606854 27620 rpc_server.cc:307] RPC server started. Bound to: 127.26.146.2:45611
12:09:17.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.606906 27753 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.146.2:45611 every 8 connection(s)
12:09:17.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.608254 27620 server_base.cc:1193] Dumped server information to /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/data/info.pb
12:09:17.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.618520 27208 external_mini_cluster.cc:1434] Started /tmp/dist-test-taski5ebua/build/asan/bin/kudu as pid 27620
12:09:17.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.618711 27208 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-1/wal/instance
12:09:17.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.623356 27208 external_mini_cluster.cc:1372] Running /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:17.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taski5ebua/build/asan/bin/kudu
12:09:17.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/wal
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/data
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/logs
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/data/info.pb
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
12:09:17.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.3:0
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.146.3
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.3
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:17.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:17.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
12:09:17.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.636076 27755 heartbeater.cc:344] Connected to a master server at 127.26.146.62:37897
12:09:17.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.636441 27755 heartbeater.cc:461] Registering TS with master...
12:09:17.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.637660 27755 heartbeater.cc:507] Master 127.26.146.62:37897 requested a full tablet report, sending...
12:09:17.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.639849 27250 ts_manager.cc:194] Registered new tserver with Master: 910b9dd2497c48a49f3a734383328b5f (127.26.146.2:45611)
12:09:17.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.640900 27250 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.26.146.2:42537
12:09:17.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.645143 27754 heartbeater.cc:344] Connected to a master server at 127.26.146.60:38097
12:09:17.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.645265 27754 heartbeater.cc:461] Registering TS with master...
12:09:17.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.645521 27754 heartbeater.cc:507] Master 127.26.146.60:38097 requested a full tablet report, sending...
12:09:17.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.647033 27391 ts_manager.cc:194] Registered new tserver with Master: 910b9dd2497c48a49f3a734383328b5f (127.26.146.2:45611)
12:09:17.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.648553 27756 heartbeater.cc:344] Connected to a master server at 127.26.146.61:36791
12:09:17.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.648722 27756 heartbeater.cc:461] Registering TS with master...
12:09:17.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.648972 27756 heartbeater.cc:507] Master 127.26.146.61:36791 requested a full tablet report, sending...
12:09:17.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.650018 27321 ts_manager.cc:194] Registered new tserver with Master: 910b9dd2497c48a49f3a734383328b5f (127.26.146.2:45611)
12:09:17.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.974860 27761 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
12:09:17.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.975226 27761 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
12:09:17.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.975343 27761 flags.cc:432] Enabled unsafe flag: --never_fsync=true
12:09:17.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.983793 27761 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
12:09:17.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:17.984016 27761 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.146.3
12:09:17.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.994300 27761 tablet_server_runner.cc:78] Tablet server non-default flags:
12:09:17.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
12:09:17.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.146.20:36397
12:09:17.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/data
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/wal
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.146.3:0
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/data/info.pb
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.146.3
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.146.62:37897,127.26.146.61:36791,127.26.146.60:38097
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
12:09:17.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.146.3
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/logs
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 8aadabe0236da0a312e7e3764fada9dc81e70c40
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
12:09:17.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 11:49:08 UTC on bdcb31816ec0
12:09:17.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16856
12:09:17.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
12:09:17.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.996505 27761 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
12:09:17.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:17.998731 27761 file_cache.cc:492] Constructed file cache file cache with capacity 419430
12:09:18.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:18.008343 27766 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
12:09:18.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:18.008548 27767 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
12:09:18.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:18.009079 27769 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
12:09:18.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.009640 27761 server_base.cc:1061] running on GCE node
12:09:18.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.010255 27761 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
12:09:18.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.011210 27761 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
12:09:18.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.012439 27761 hybrid_clock.cc:648] HybridClock initialized: now 1783512558012378 us; error 49 us; skew 500 ppm
12:09:18.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.012787 27761 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
12:09:18.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.015008 27761 webserver.cc:533] Webserver started at http://127.26.146.3:40123/ using document root <none> and password file <none>
12:09:18.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.015749 27761 fs_manager.cc:362] Metadata directory not provided
12:09:18.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.015875 27761 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
12:09:18.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.016258 27761 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
12:09:18.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.019248 27761 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/data/instance:
12:09:18.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ddccdea1e50c48bf919b12ac0b15dcab"
12:09:18.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:18 on dist-test-slave-1ld0"
12:09:18.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.020072 27761 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/wal/instance:
12:09:18.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ddccdea1e50c48bf919b12ac0b15dcab"
12:09:18.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:18 on dist-test-slave-1ld0"
12:09:18.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.025468 27761 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.003s	sys 0.003s
12:09:18.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.029490 27775 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
12:09:18.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.030817 27761 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.002s
12:09:18.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.031002 27761 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/data,/tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/wal
12:09:18.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ddccdea1e50c48bf919b12ac0b15dcab"
12:09:18.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 12:09:18 on dist-test-slave-1ld0"
12:09:18.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.031250 27761 fs_report.cc:389] FS layout report
12:09:18.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
12:09:18.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/wal
12:09:18.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/wal
12:09:18.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/data/data
12:09:18.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
12:09:18.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
12:09:18.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
12:09:18.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
12:09:18.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
12:09:18.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
12:09:18.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
12:09:18.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
12:09:18.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
12:09:18.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
12:09:18.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
12:09:18.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.084867 27761 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
12:09:18.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.085842 27761 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
12:09:18.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.086170 27761 kserver.cc:163] Server-wide thread pool size limit: 3276
12:09:18.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.087234 27761 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
12:09:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.089367 27761 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
12:09:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.089486 27761 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
12:09:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.089587 27761 ts_tablet_manager.cc:616] Registered 0 tablets
12:09:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.089666 27761 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
12:09:18.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.125667 27761 rpc_server.cc:307] RPC server started. Bound to: 127.26.146.3:35479
12:09:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.125757 27887 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.146.3:35479 every 8 connection(s)
12:09:18.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.127424 27761 server_base.cc:1193] Dumped server information to /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/data/info.pb
12:09:18.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.129761 27208 external_mini_cluster.cc:1434] Started /tmp/dist-test-taski5ebua/build/asan/bin/kudu as pid 27761
12:09:18.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.129916 27208 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taski5ebua/test-tmp/mini-kudu-cluster6052150830899888916/ts-2/wal/instance
12:09:18.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.148577 27617 heartbeater.cc:499] Master 127.26.146.62:37897 was elected leader, sending a full tablet report...
12:09:18.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.155197 27889 heartbeater.cc:344] Connected to a master server at 127.26.146.62:37897
12:09:18.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.155566 27889 heartbeater.cc:461] Registering TS with master...
12:09:18.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.156409 27889 heartbeater.cc:507] Master 127.26.146.62:37897 requested a full tablet report, sending...
12:09:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.157773 27890 heartbeater.cc:344] Connected to a master server at 127.26.146.61:36791
12:09:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.157804 27888 heartbeater.cc:344] Connected to a master server at 127.26.146.60:38097
12:09:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.157930 27890 heartbeater.cc:461] Registering TS with master...
12:09:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.157965 27888 heartbeater.cc:461] Registering TS with master...
12:09:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.158268 27250 ts_manager.cc:194] Registered new tserver with Master: ddccdea1e50c48bf919b12ac0b15dcab (127.26.146.3:35479)
12:09:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.158532 27890 heartbeater.cc:507] Master 127.26.146.61:36791 requested a full tablet report, sending...
12:09:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.158553 27888 heartbeater.cc:507] Master 127.26.146.60:38097 requested a full tablet report, sending...
12:09:18.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.159305 27250 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.26.146.3:55903
12:09:18.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.159718 27391 ts_manager.cc:194] Registered new tserver with Master: ddccdea1e50c48bf919b12ac0b15dcab (127.26.146.3:35479)
12:09:18.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.160596 27321 ts_manager.cc:194] Registered new tserver with Master: ddccdea1e50c48bf919b12ac0b15dcab (127.26.146.3:35479)
12:09:18.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.176438 27208 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
12:09:18.178 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
12:09:18.180 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

12:09:18.189 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.26.146.62"
      port: 37897
    }
    bound_http_address {
      host: "127.26.146.62"
      port: 40255
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.26.146.61"
      port: 36791
    }
    bound_http_address {
      host: "127.26.146.61"
      port: 37361
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.26.146.60"
      port: 38097
    }
    bound_http_address {
      host: "127.26.146.60"
      port: 38685
    }
  }
}

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

12:09:18.194 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.26.146.1"
      port: 40001
    }
    bound_http_address {
      host: "127.26.146.1"
      port: 36827
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.26.146.2"
      port: 45611
    }
    bound_http_address {
      host: "127.26.146.2"
      port: 40151
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.26.146.3"
      port: 35479
    }
    bound_http_address {
      host: "127.26.146.3"
      port: 40123
    }
  }
}

12:09:18.195 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
12:09:18.359 [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)
12:09:18.406 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
12:09:18.542 [DEBUG - main] (Connection.java:748) [peer master-127.26.146.61:36791(127.26.146.61:36791)] connecting to peer
12:09:18.590 [DEBUG - main] (Connection.java:748) [peer master-127.26.146.62:37897(127.26.146.62:37897)] connecting to peer
12:09:18.598 [DEBUG - main] (Connection.java:748) [peer master-127.26.146.60:38097(127.26.146.60:38097)] connecting to peer
12:09:18.609 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.26.146.60:38097(127.26.146.60:38097)] Successfully connected to peer
12:09:18.614 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.26.146.61:36791(127.26.146.61:36791)] Successfully connected to peer
12:09:18.615 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.26.146.62:37897(127.26.146.62:37897)] Successfully connected to peer
12:09:18.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:18.644575 27755 heartbeater.cc:499] Master 127.26.146.62:37897 was elected leader, sending a full tablet report...
12:09:18.711 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.26.146.62
12:09:18.711 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.26.146.60
12:09:18.712 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.26.146.61
12:09:18.939 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x2821b991, L:/127.0.0.1:50682 - R:/127.26.146.62:37897] using SASL/PLAIN
12:09:18.939 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x19b87489, L:/127.0.0.1:54524 - R:/127.26.146.61:36791] using SASL/PLAIN
12:09:18.941 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x033e1782, L:/127.0.0.1:46922 - R:/127.26.146.60:38097] using SASL/PLAIN
12:09:18.974 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
12:09:18.975 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=469), Traces: [0ms] refreshing cache from master, [24ms] Sub RPC ConnectToMaster: sending RPC to server master-127.26.146.61:36791, [81ms] Sub RPC ConnectToMaster: sending RPC to server master-127.26.146.62:37897, [89ms] Sub RPC ConnectToMaster: sending RPC to server master-127.26.146.60:38097, [442ms] Sub RPC ConnectToMaster: received response from server master-127.26.146.61:36791: OK, [443ms] Sub RPC ConnectToMaster: received response from server master-127.26.146.60:38097: OK, [445ms] Sub RPC ConnectToMaster: received response from server master-127.26.146.62:37897: OK, deferred=null) after lookup
12:09:19.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.024487 27250 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:50682:
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783512554000"
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
12:09:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
12:09:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
12:09:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
12:09:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:19.026026 27250 catalog_manager.cc:7077] 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-1783512554000 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
12:09:19.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.089821 27689 tablet_service.cc:1511] Processing CreateTablet for tablet f25fc0f50a3c43a6aee535bb7ea8b1f5 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783512554000 [id=076d552bd3534e70b3cfdfd8750de2c6]), partition=RANGE (key) PARTITION UNBOUNDED
12:09:19.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.091998 27689 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet f25fc0f50a3c43a6aee535bb7ea8b1f5. 1 dirs total, 0 dirs full, 0 dirs failed
12:09:19.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.101073 27823 tablet_service.cc:1511] Processing CreateTablet for tablet f25fc0f50a3c43a6aee535bb7ea8b1f5 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783512554000 [id=076d552bd3534e70b3cfdfd8750de2c6]), partition=RANGE (key) PARTITION UNBOUNDED
12:09:19.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.102877 27823 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet f25fc0f50a3c43a6aee535bb7ea8b1f5. 1 dirs total, 0 dirs full, 0 dirs failed
12:09:19.106 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 076d552bd3534e70b3cfdfd8750de2c6
12:09:19.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.112977 27917 tablet_bootstrap.cc:492] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f: Bootstrap starting.
12:09:19.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.114548 27551 tablet_service.cc:1511] Processing CreateTablet for tablet f25fc0f50a3c43a6aee535bb7ea8b1f5 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783512554000 [id=076d552bd3534e70b3cfdfd8750de2c6]), partition=RANGE (key) PARTITION UNBOUNDED
12:09:19.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.116015 27551 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet f25fc0f50a3c43a6aee535bb7ea8b1f5. 1 dirs total, 0 dirs full, 0 dirs failed
12:09:19.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.116546 27918 tablet_bootstrap.cc:492] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab: Bootstrap starting.
12:09:19.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.116927 27917 tablet_bootstrap.cc:654] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f: Neither blocks nor log segments found. Creating new log.
12:09:19.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.118410 27917 log.cc:826] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f: Log is configured to *not* fsync() on all Append() calls
12:09:19.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.122200 27918 tablet_bootstrap.cc:654] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab: Neither blocks nor log segments found. Creating new log.
12:09:19.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.124215 27918 log.cc:826] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab: Log is configured to *not* fsync() on all Append() calls
12:09:19.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.156275 27918 tablet_bootstrap.cc:492] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab: No bootstrap required, opened a new log
12:09:19.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.156599 27918 ts_tablet_manager.cc:1403] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab: Time spent bootstrapping tablet: real 0.040s	user 0.004s	sys 0.031s
12:09:19.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.158849 27917 tablet_bootstrap.cc:492] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f: No bootstrap required, opened a new log
12:09:19.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.159209 27917 ts_tablet_manager.cc:1403] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f: Time spent bootstrapping tablet: real 0.047s	user 0.025s	sys 0.015s
12:09:19.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.162038 27889 heartbeater.cc:499] Master 127.26.146.62:37897 was elected leader, sending a full tablet report...
12:09:19.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.163201 27918 raft_consensus.cc:359] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "86d2e94781964fb5bce88aee72827e05" member_type: VOTER last_known_addr { host: "127.26.146.1" port: 40001 } } peers { permanent_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" member_type: VOTER last_known_addr { host: "127.26.146.3" port: 35479 } } peers { permanent_uuid: "910b9dd2497c48a49f3a734383328b5f" member_type: VOTER last_known_addr { host: "127.26.146.2" port: 45611 } }
12:09:19.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.163614 27918 raft_consensus.cc:385] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
12:09:19.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.163708 27918 raft_consensus.cc:740] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ddccdea1e50c48bf919b12ac0b15dcab, State: Initialized, Role: FOLLOWER
12:09:19.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.164506 27918 consensus_queue.cc:260] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab [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: "86d2e94781964fb5bce88aee72827e05" member_type: VOTER last_known_addr { host: "127.26.146.1" port: 40001 } } peers { permanent_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" member_type: VOTER last_known_addr { host: "127.26.146.3" port: 35479 } } peers { permanent_uuid: "910b9dd2497c48a49f3a734383328b5f" member_type: VOTER last_known_addr { host: "127.26.146.2" port: 45611 } }
12:09:19.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.170310 27921 tablet_bootstrap.cc:492] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05: Bootstrap starting.
12:09:19.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.172372 27917 raft_consensus.cc:359] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "86d2e94781964fb5bce88aee72827e05" member_type: VOTER last_known_addr { host: "127.26.146.1" port: 40001 } } peers { permanent_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" member_type: VOTER last_known_addr { host: "127.26.146.3" port: 35479 } } peers { permanent_uuid: "910b9dd2497c48a49f3a734383328b5f" member_type: VOTER last_known_addr { host: "127.26.146.2" port: 45611 } }
12:09:19.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.172956 27917 raft_consensus.cc:385] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
12:09:19.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.173230 27917 raft_consensus.cc:740] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 910b9dd2497c48a49f3a734383328b5f, State: Initialized, Role: FOLLOWER
12:09:19.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.174074 27917 consensus_queue.cc:260] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f [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: "86d2e94781964fb5bce88aee72827e05" member_type: VOTER last_known_addr { host: "127.26.146.1" port: 40001 } } peers { permanent_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" member_type: VOTER last_known_addr { host: "127.26.146.3" port: 35479 } } peers { permanent_uuid: "910b9dd2497c48a49f3a734383328b5f" member_type: VOTER last_known_addr { host: "127.26.146.2" port: 45611 } }
12:09:19.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.175606 27921 tablet_bootstrap.cc:654] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05: Neither blocks nor log segments found. Creating new log.
12:09:19.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.178264 27921 log.cc:826] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05: Log is configured to *not* fsync() on all Append() calls
12:09:19.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.183444 27917 ts_tablet_manager.cc:1434] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f: Time spent starting tablet: real 0.024s	user 0.013s	sys 0.006s
12:09:19.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.183904 27918 ts_tablet_manager.cc:1434] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab: Time spent starting tablet: real 0.027s	user 0.005s	sys 0.006s
12:09:19.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.196593 27921 tablet_bootstrap.cc:492] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05: No bootstrap required, opened a new log
12:09:19.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.196879 27921 ts_tablet_manager.cc:1403] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05: Time spent bootstrapping tablet: real 0.027s	user 0.013s	sys 0.007s
12:09:19.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.202011 27921 raft_consensus.cc:359] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "86d2e94781964fb5bce88aee72827e05" member_type: VOTER last_known_addr { host: "127.26.146.1" port: 40001 } } peers { permanent_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" member_type: VOTER last_known_addr { host: "127.26.146.3" port: 35479 } } peers { permanent_uuid: "910b9dd2497c48a49f3a734383328b5f" member_type: VOTER last_known_addr { host: "127.26.146.2" port: 45611 } }
12:09:19.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.202291 27921 raft_consensus.cc:385] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
12:09:19.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.202414 27921 raft_consensus.cc:740] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 86d2e94781964fb5bce88aee72827e05, State: Initialized, Role: FOLLOWER
12:09:19.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.202970 27921 consensus_queue.cc:260] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [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: "86d2e94781964fb5bce88aee72827e05" member_type: VOTER last_known_addr { host: "127.26.146.1" port: 40001 } } peers { permanent_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" member_type: VOTER last_known_addr { host: "127.26.146.3" port: 35479 } } peers { permanent_uuid: "910b9dd2497c48a49f3a734383328b5f" member_type: VOTER last_known_addr { host: "127.26.146.2" port: 45611 } }
12:09:19.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.204531 27921 ts_tablet_manager.cc:1434] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05: Time spent starting tablet: real 0.008s	user 0.008s	sys 0.000s
12:09:19.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.342543 27925 raft_consensus.cc:493] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
12:09:19.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.342849 27925 raft_consensus.cc:515] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "86d2e94781964fb5bce88aee72827e05" member_type: VOTER last_known_addr { host: "127.26.146.1" port: 40001 } } peers { permanent_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" member_type: VOTER last_known_addr { host: "127.26.146.3" port: 35479 } } peers { permanent_uuid: "910b9dd2497c48a49f3a734383328b5f" member_type: VOTER last_known_addr { host: "127.26.146.2" port: 45611 } }
12:09:19.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.344723 27925 leader_election.cc:290] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers ddccdea1e50c48bf919b12ac0b15dcab (127.26.146.3:35479), 910b9dd2497c48a49f3a734383328b5f (127.26.146.2:45611)
12:09:19.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.352010 27709 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "f25fc0f50a3c43a6aee535bb7ea8b1f5" candidate_uuid: "86d2e94781964fb5bce88aee72827e05" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "910b9dd2497c48a49f3a734383328b5f" is_pre_election: true
12:09:19.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.352123 27843 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "f25fc0f50a3c43a6aee535bb7ea8b1f5" candidate_uuid: "86d2e94781964fb5bce88aee72827e05" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" is_pre_election: true
12:09:19.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.352408 27709 raft_consensus.cc:2468] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 86d2e94781964fb5bce88aee72827e05 in term 0.
12:09:19.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.352648 27843 raft_consensus.cc:2468] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 86d2e94781964fb5bce88aee72827e05 in term 0.
12:09:19.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.352989 27507 leader_election.cc:304] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [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: 86d2e94781964fb5bce88aee72827e05, 910b9dd2497c48a49f3a734383328b5f; no voters: 
12:09:19.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.353421 27925 raft_consensus.cc:2804] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [term 0 FOLLOWER]: Leader pre-election won for term 1
12:09:19.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.353539 27925 raft_consensus.cc:493] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
12:09:19.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.353652 27925 raft_consensus.cc:3060] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [term 0 FOLLOWER]: Advancing to term 1
12:09:19.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.355690 27925 raft_consensus.cc:515] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "86d2e94781964fb5bce88aee72827e05" member_type: VOTER last_known_addr { host: "127.26.146.1" port: 40001 } } peers { permanent_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" member_type: VOTER last_known_addr { host: "127.26.146.3" port: 35479 } } peers { permanent_uuid: "910b9dd2497c48a49f3a734383328b5f" member_type: VOTER last_known_addr { host: "127.26.146.2" port: 45611 } }
12:09:19.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.356276 27925 leader_election.cc:290] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [CANDIDATE]: Term 1 election: Requested vote from peers ddccdea1e50c48bf919b12ac0b15dcab (127.26.146.3:35479), 910b9dd2497c48a49f3a734383328b5f (127.26.146.2:45611)
12:09:19.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.356642 27843 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "f25fc0f50a3c43a6aee535bb7ea8b1f5" candidate_uuid: "86d2e94781964fb5bce88aee72827e05" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ddccdea1e50c48bf919b12ac0b15dcab"
12:09:19.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.356774 27709 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "f25fc0f50a3c43a6aee535bb7ea8b1f5" candidate_uuid: "86d2e94781964fb5bce88aee72827e05" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "910b9dd2497c48a49f3a734383328b5f"
12:09:19.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.356842 27843 raft_consensus.cc:3060] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab [term 0 FOLLOWER]: Advancing to term 1
12:09:19.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.356915 27709 raft_consensus.cc:3060] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f [term 0 FOLLOWER]: Advancing to term 1
12:09:19.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.358984 27843 raft_consensus.cc:2468] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 86d2e94781964fb5bce88aee72827e05 in term 1.
12:09:19.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.359345 27709 raft_consensus.cc:2468] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 86d2e94781964fb5bce88aee72827e05 in term 1.
12:09:19.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.359405 27504 leader_election.cc:304] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [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: 86d2e94781964fb5bce88aee72827e05, ddccdea1e50c48bf919b12ac0b15dcab; no voters: 
12:09:19.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.359725 27925 raft_consensus.cc:2804] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [term 1 FOLLOWER]: Leader election won for term 1
12:09:19.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.360275 27925 raft_consensus.cc:697] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [term 1 LEADER]: Becoming Leader. State: Replica: 86d2e94781964fb5bce88aee72827e05, State: Running, Role: LEADER
12:09:19.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.360790 27925 consensus_queue.cc:237] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [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: "86d2e94781964fb5bce88aee72827e05" member_type: VOTER last_known_addr { host: "127.26.146.1" port: 40001 } } peers { permanent_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" member_type: VOTER last_known_addr { host: "127.26.146.3" port: 35479 } } peers { permanent_uuid: "910b9dd2497c48a49f3a734383328b5f" member_type: VOTER last_known_addr { host: "127.26.146.2" port: 45611 } }
12:09:19.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.365955 27250 catalog_manager.cc:5697] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 reported cstate change: term changed from 0 to 1, leader changed from <none> to 86d2e94781964fb5bce88aee72827e05 (127.26.146.1). New cstate: current_term: 1 leader_uuid: "86d2e94781964fb5bce88aee72827e05" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "86d2e94781964fb5bce88aee72827e05" member_type: VOTER last_known_addr { host: "127.26.146.1" port: 40001 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" member_type: VOTER last_known_addr { host: "127.26.146.3" port: 35479 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "910b9dd2497c48a49f3a734383328b5f" member_type: VOTER last_known_addr { host: "127.26.146.2" port: 45611 } health_report { overall_health: UNKNOWN } } }
12:09:19.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:19.389772 27626 tablet.cc:2406] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05: Can't schedule compaction. Clean time has not been advanced past its initial value.
12:09:19.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:19.392347 27759 tablet.cc:2406] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f: Can't schedule compaction. Clean time has not been advanced past its initial value.
12:09:19.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 12:09:19.393224 27891 tablet.cc:2406] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab: Can't schedule compaction. Clean time has not been advanced past its initial value.
12:09:19.439 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet f25fc0f50a3c43a6aee535bb7ea8b1f5 for table 'org.apache.kudu.client.TestHybridTime-1783512554000' with partition [<start>, <end>)
12:09:19.444 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299995, tablet=f25fc0f50a3c43a6aee535bb7ea8b1f5@[86d2e94781964fb5bce88aee72827e05(127.26.146.1:40001)[L],910b9dd2497c48a49f3a734383328b5f(127.26.146.2:45611),ddccdea1e50c48bf919b12ac0b15dcab(127.26.146.3:35479)]}]
12:09:19.445 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=15), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.26.146.62:37897, [8ms] Sub RPC GetTableLocations: received response from server master-127.26.146.62:37897: OK, deferred=null) after lookup
12:09:19.454 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 86d2e94781964fb5bce88aee72827e05(127.26.146.1:40001)] connecting to peer
12:09:19.456 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 86d2e94781964fb5bce88aee72827e05(127.26.146.1:40001)] Successfully connected to peer
12:09:19.521 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x7dc9c617, L:/127.0.0.1:43902 - R:/127.26.146.1:40001] using TOKEN/null
12:09:19.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.531924 27709 raft_consensus.cc:1275] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 910b9dd2497c48a49f3a734383328b5f [term 1 FOLLOWER]: Refusing update from remote peer 86d2e94781964fb5bce88aee72827e05: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
12:09:19.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.532104 27843 raft_consensus.cc:1275] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P ddccdea1e50c48bf919b12ac0b15dcab [term 1 FOLLOWER]: Refusing update from remote peer 86d2e94781964fb5bce88aee72827e05: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
12:09:19.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.533069 27925 consensus_queue.cc:1048] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [LEADER]: Connected to new peer: Peer: permanent_uuid: "ddccdea1e50c48bf919b12ac0b15dcab" member_type: VOTER last_known_addr { host: "127.26.146.3" port: 35479 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
12:09:19.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.533358 27928 consensus_queue.cc:1048] T f25fc0f50a3c43a6aee535bb7ea8b1f5 P 86d2e94781964fb5bce88aee72827e05 [LEADER]: Connected to new peer: Peer: permanent_uuid: "910b9dd2497c48a49f3a734383328b5f" member_type: VOTER last_known_addr { host: "127.26.146.2" port: 45611 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
12:09:19.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.545042 27934 mvcc.cc:204] Tried to move back new op lower bound from 7305267443831767040 to 7305267443145433088. Current Snapshot: MvccSnapshot[applied={T|T < 7305267443831767040}]
12:09:19.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.545531 27933 mvcc.cc:204] Tried to move back new op lower bound from 7305267443831767040 to 7305267443145433088. Current Snapshot: MvccSnapshot[applied={T|T < 7305267443831767040}]
12:09:19.588 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
12:09:19.602 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
12:09:19.611 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
12:09:19.616 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1172404532(state=PENDING, result=null, callback=<none>, errback=<none>)}
12:09:19.628 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
12:09:19.629 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@885536826(state=PENDING, result=null, callback=<none>, errback=<none>)}
12:09:19.638 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
12:09:19.638 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@2025296905(state=PENDING, result=null, callback=<none>, errback=<none>)}
12:09:19.647 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
12:09:19.696 [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-1783512554000, tablet=f25fc0f50a3c43a6aee535bb7ea8b1f5, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
12:09:19.705 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305267464311767041) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783512554000, tablet=f25fc0f50a3c43a6aee535bb7ea8b1f5, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
12:09:19.711 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305267464311767045) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783512554000, tablet=f25fc0f50a3c43a6aee535bb7ea8b1f5, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
12:09:19.717 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305267464311767049) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783512554000, tablet=f25fc0f50a3c43a6aee535bb7ea8b1f5, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
12:09:19.723 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305267464311767053) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783512554000, tablet=f25fc0f50a3c43a6aee535bb7ea8b1f5, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
12:09:19.728 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305267464311767057) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783512554000, tablet=f25fc0f50a3c43a6aee535bb7ea8b1f5, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
12:09:19.734 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305267464311767063) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783512554000, tablet=f25fc0f50a3c43a6aee535bb7ea8b1f5, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
12:09:19.740 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305267464311767064) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783512554000, tablet=f25fc0f50a3c43a6aee535bb7ea8b1f5, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
12:09:19.743 [DEBUG - main] (Connection.java:575) [peer master-127.26.146.60:38097(127.26.146.60:38097)] disconnecting while in state READY
12:09:19.744 [DEBUG - main] (Connection.java:575) [peer 86d2e94781964fb5bce88aee72827e05(127.26.146.1:40001)] disconnecting while in state READY
12:09:19.744 [DEBUG - main] (Connection.java:575) [peer master-127.26.146.62:37897(127.26.146.62:37897)] disconnecting while in state READY
12:09:19.748 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.26.146.62:37897(127.26.146.62:37897)] handling channelInactive
12:09:19.748 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.26.146.60:38097(127.26.146.60:38097)] handling channelInactive
12:09:19.749 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.26.146.62:37897(127.26.146.62:37897)] cleaning up while in state READY due to: connection closed
12:09:19.749 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.26.146.60:38097(127.26.146.60:38097)] cleaning up while in state READY due to: connection closed
12:09:19.749 [DEBUG - main] (Connection.java:575) [peer master-127.26.146.61:36791(127.26.146.61:36791)] disconnecting while in state READY
12:09:19.751 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.26.146.61:36791(127.26.146.61:36791)] handling channelInactive
12:09:19.751 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
12:09:19.752 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.26.146.61:36791(127.26.146.61:36791)] cleaning up while in state READY due to: connection closed
12:09:19.757 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 86d2e94781964fb5bce88aee72827e05(127.26.146.1:40001)] handling channelInactive
12:09:19.757 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 86d2e94781964fb5bce88aee72827e05(127.26.146.1:40001)] cleaning up while in state READY due to: connection closed
12:09:19.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.757822 27208 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taski5ebua/build/asan/bin/kudu pid 27488
12:09:19.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.774652 27611 generic_service.cc:196] Checking for leaks (request via RPC)
12:09:19.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.881254 27208 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taski5ebua/build/asan/bin/kudu with pid 27488
12:09:19.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.897109 27208 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taski5ebua/build/asan/bin/kudu pid 27620
12:09:19.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.905330 27749 generic_service.cc:196] Checking for leaks (request via RPC)
12:09:19.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:19.994649 27208 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taski5ebua/build/asan/bin/kudu with pid 27620
12:09:20.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.011761 27208 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taski5ebua/build/asan/bin/kudu pid 27761
12:09:20.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.018479 27883 generic_service.cc:196] Checking for leaks (request via RPC)
12:09:20.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.109092 27208 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taski5ebua/build/asan/bin/kudu with pid 27761
12:09:20.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.126520 27208 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taski5ebua/build/asan/bin/kudu pid 27219
12:09:20.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.127640 27280 generic_service.cc:196] Checking for leaks (request via RPC)
12:09:20.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.242126 27208 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taski5ebua/build/asan/bin/kudu with pid 27219
12:09:20.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.265340 27208 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taski5ebua/build/asan/bin/kudu pid 27287
12:09:20.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.266489 27351 generic_service.cc:196] Checking for leaks (request via RPC)
12:09:20.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.371009 27208 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taski5ebua/build/asan/bin/kudu with pid 27287
12:09:20.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.390954 27208 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taski5ebua/build/asan/bin/kudu pid 27358
12:09:20.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.392017 27422 generic_service.cc:196] Checking for leaks (request via RPC)
12:09:20.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 12:09:20.496603 27208 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taski5ebua/build/asan/bin/kudu with pid 27358
12:09:20.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T12:09:20Z chronyd exiting

Time: 6.549

OK (1 test)

