JUnit version 4.13.2
.14:30:08.311 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783521008301
14:30:08.341 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
14:30:08.382 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
14:30:08.392 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskK2dDP_/test-tmp
14:30:08.424 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
14:30:08.428 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskK2dDP_/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
14:30:08.664 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

14:30:08.843 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:30:08.845 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

14:30:08.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:08.850641 17222 mini_oidc.cc:150] Starting JWKS server
14:30:08.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:08.854857 17222 webserver.cc:533] Webserver started at http://127.0.0.1:33909/ using document root <none> and password file <none>
14:30:08.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:08.855474 17222 mini_oidc.cc:186] Starting OIDC Discovery server
14:30:08.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:08.857919 17222 webserver.cc:533] Webserver started at http://127.0.0.1:33065/ using document root <none> and password file <none>
14:30:08.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T14:30:08Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
14:30:08.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T14:30:08Z Disabled control of system clock
14:30:08.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:08.923890 17222 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:08.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:08.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/wal
14:30:08.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/data
14:30:08.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:30:08.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:30:08.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:30:08.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:08.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:08.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:08.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/logs
14:30:08.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/data/info.pb
14:30:08.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:08.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:30:08.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:30:08.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:30:08.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:30:08.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:08.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:08.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:08.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:30:08.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:30:08.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:30:08.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:30:08.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.190:42029
14:30:08.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.190
14:30:08.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:08.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:08.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:08.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:08.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:30:08.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:30:08.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:08.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:30:08.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33909/jwks.json with env {}
14:30:09.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:09.261449 17234 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:30:09.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:09.261994 17234 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:30:09.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:09.262423 17234 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:30:09.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:09.295419 17234 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:30:09.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:09.295809 17234 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:30:09.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:09.296023 17234 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:30:09.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:09.296216 17234 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:30:09.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:09.296461 17234 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:30:09.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:09.296680 17234 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:33909/jwks.json
14:30:09.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:09.334758 17234 master_runner.cc:387] Master server non-default flags:
14:30:09.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:09.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:09.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:09.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:30:09.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/data
14:30:09.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/wal
14:30:09.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:30:09.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:09.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:09.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:09.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:30:09.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.190:42029
14:30:09.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:30:09.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:30:09.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:30:09.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33909/jwks.json
14:30:09.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:09.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:09.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/data/info.pb
14:30:09.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.190
14:30:09.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:09.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:30:09.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:09.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:30:09.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:30:09.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:09.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/logs
14:30:09.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:09.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:30:09.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:30:09.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:30:09.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:30:09.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:30:09.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:30:09.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 14:12:00 UTC on bdcb31816ec0
14:30:09.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16864
14:30:09.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:30:09.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:09.336339 17234 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:30:09.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:09.338243 17234 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:30:09.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:09.349668 17240 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:10.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:09.350137 17241 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:10.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:10.609443 17243 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:10.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:10.613554 17242 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1261 milliseconds
14:30:10.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:10.614627 17234 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.265s	user 0.412s	sys 0.842s
14:30:10.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:10.615012 17234 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.265s	user 0.412s	sys 0.842s
14:30:10.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.615310 17234 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
14:30:10.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.617408 17234 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:30:10.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.620846 17234 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:30:10.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.622773 17234 hybrid_clock.cc:648] HybridClock initialized: now 1783521010622718 us; error 63 us; skew 500 ppm
14:30:10.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.624032 17234 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:30:10.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.634441 17234 webserver.cc:533] Webserver started at http://127.16.209.190:34559/ using document root <none> and password file <none>
14:30:10.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.635898 17234 fs_manager.cc:362] Metadata directory not provided
14:30:10.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.636215 17234 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:30:10.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.636839 17234 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:30:10.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.644333 17234 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/data/instance:
14:30:10.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "842194925e8446f7ab806a2e674fb77b"
14:30:10.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:10 on dist-test-slave-kjw1"
14:30:10.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.646042 17234 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/wal/instance:
14:30:10.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "842194925e8446f7ab806a2e674fb77b"
14:30:10.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:10 on dist-test-slave-kjw1"
14:30:10.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.657203 17234 fs_manager.cc:696] Time spent creating directory manager: real 0.010s	user 0.007s	sys 0.005s
14:30:10.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.665377 17250 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:30:10.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.667136 17234 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.003s	sys 0.002s
14:30:10.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.667531 17234 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/data,/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/wal
14:30:10.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "842194925e8446f7ab806a2e674fb77b"
14:30:10.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:10 on dist-test-slave-kjw1"
14:30:10.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.668002 17234 fs_report.cc:389] FS layout report
14:30:10.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:30:10.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/wal
14:30:10.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/wal
14:30:10.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/data/data
14:30:10.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:30:10.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:30:10.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:30:10.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:30:10.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:30:10.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:30:10.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:30:10.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:30:10.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:30:10.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:30:10.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:30:10.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.772063 17234 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:30:10.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.773732 17234 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:30:10.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.774262 17234 kserver.cc:163] Server-wide thread pool size limit: 3276
14:30:10.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.848879 17234 rpc_server.cc:307] RPC server started. Bound to: 127.16.209.190:42029
14:30:10.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.848994 17301 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.209.190:42029 every 8 connection(s)
14:30:10.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.851850 17234 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/data/info.pb
14:30:10.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.857642 17302 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:30:10.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.861452 17222 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu as pid 17234
14:30:10.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.861965 17222 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-0/wal/instance
14:30:10.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.867148 17222 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:10.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:10.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/wal
14:30:10.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/data
14:30:10.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:30:10.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:30:10.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:30:10.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:10.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:10.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:10.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/logs
14:30:10.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/data/info.pb
14:30:10.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:10.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:30:10.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:30:10.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:30:10.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:30:10.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:10.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:10.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:10.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:30:10.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:30:10.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:30:10.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:30:10.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.189:37189
14:30:10.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.189
14:30:10.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:10.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:10.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:10.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:10.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:30:10.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:30:10.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:10.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:30:10.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33909/jwks.json with env {}
14:30:10.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.872182 17302 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } has no permanent_uuid. Determining permanent_uuid...
14:30:10.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.903393 17302 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } has no permanent_uuid. Determining permanent_uuid...
14:30:10.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:10.906242 17252 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.16.209.189:37189: connect: Connection refused (error 111)
14:30:10.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:10.911116 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.189:37189: Network error: Client connection negotiation failed: client connection to 127.16.209.189:37189: connect: Connection refused (error 111)
14:30:10.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:10.960633 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } attempt: 1
14:30:10.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:10.966226 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.189:37189: Network error: Client connection negotiation failed: client connection to 127.16.209.189:37189: connect: Connection refused (error 111)
14:30:11.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:11.034709 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } attempt: 2
14:30:11.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.040190 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.189:37189: Network error: Client connection negotiation failed: client connection to 127.16.209.189:37189: connect: Connection refused (error 111)
14:30:11.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:11.131717 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } attempt: 3
14:30:11.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.136162 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.189:37189: Network error: Client connection negotiation failed: client connection to 127.16.209.189:37189: connect: Connection refused (error 111)
14:30:11.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.197283 17304 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:30:11.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.197847 17304 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:30:11.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.198437 17304 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:30:11.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.231114 17304 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:30:11.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.231411 17304 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:30:11.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.231608 17304 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:30:11.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.231911 17304 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:30:11.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.232102 17304 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:30:11.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.232349 17304 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:33909/jwks.json
14:30:11.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:11.270460 17304 master_runner.cc:387] Master server non-default flags:
14:30:11.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:11.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:11.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:11.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:30:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/data
14:30:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/wal
14:30:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:30:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:30:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.189:37189
14:30:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:30:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:30:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:30:11.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33909/jwks.json
14:30:11.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:11.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:11.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/data/info.pb
14:30:11.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.189
14:30:11.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:11.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:30:11.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:11.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:30:11.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:30:11.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:11.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/logs
14:30:11.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:11.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:30:11.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:30:11.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:30:11.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:30:11.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:30:11.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:30:11.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 14:12:00 UTC on bdcb31816ec0
14:30:11.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16864
14:30:11.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:30:11.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:11.271834 17304 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:30:11.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:11.273716 17304 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:30:11.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:11.279613 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } attempt: 4
14:30:11.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.285553 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.189:37189: Network error: Client connection negotiation failed: client connection to 127.16.209.189:37189: connect: Connection refused (error 111)
14:30:11.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.286819 17313 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:11.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:11.585052 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } attempt: 5
14:30:11.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.594871 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.189:37189: Network error: Client connection negotiation failed: client connection to 127.16.209.189:37189: connect: Connection refused (error 111)
14:30:12.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.143711 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } attempt: 6
14:30:12.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:12.170857 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.189:37189: Network error: Client connection negotiation failed: client connection to 127.16.209.189:37189: connect: Connection refused (error 111)
14:30:12.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:11.289371 17314 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:12.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:12.691582 17312 debug-util.cc:398] Leaking SignalData structure 0x7b0800028020 after lost signal to thread 17304
14:30:12.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:12.870980 17304 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.582s	user 0.524s	sys 1.053s
14:30:12.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:12.872642 17304 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.584s	user 0.524s	sys 1.054s
14:30:12.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:12.873703 17315 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1580 milliseconds
14:30:12.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:12.874042 17316 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:12.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.874182 17304 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
14:30:12.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.877626 17304 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:30:12.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.880012 17304 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:30:12.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.881583 17304 hybrid_clock.cc:648] HybridClock initialized: now 1783521012881511 us; error 34 us; skew 500 ppm
14:30:12.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.882912 17304 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:30:12.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.889797 17304 webserver.cc:533] Webserver started at http://127.16.209.189:36505/ using document root <none> and password file <none>
14:30:12.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.891098 17304 fs_manager.cc:362] Metadata directory not provided
14:30:12.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.891379 17304 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:30:12.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.891978 17304 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:30:12.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.896520 17304 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/data/instance:
14:30:12.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1efb1f2e0a644521a25881d4cb520b79"
14:30:12.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:12 on dist-test-slave-kjw1"
14:30:12.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.897828 17304 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/wal/instance:
14:30:12.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1efb1f2e0a644521a25881d4cb520b79"
14:30:12.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:12 on dist-test-slave-kjw1"
14:30:12.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.905170 17304 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.006s	sys 0.002s
14:30:12.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.910948 17325 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:30:12.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.912053 17304 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.001s
14:30:12.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.912418 17304 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/data,/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/wal
14:30:12.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1efb1f2e0a644521a25881d4cb520b79"
14:30:12.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:12 on dist-test-slave-kjw1"
14:30:12.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.912806 17304 fs_report.cc:389] FS layout report
14:30:12.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:30:12.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/wal
14:30:12.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/wal
14:30:12.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/data/data
14:30:12.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:30:12.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:30:12.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:30:12.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:30:12.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:30:12.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:30:12.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:30:12.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:30:12.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:30:12.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:30:12.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:30:12.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.970553 17304 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:30:12.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.972326 17304 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:30:12.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:12.972873 17304 kserver.cc:163] Server-wide thread pool size limit: 3276
14:30:13.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.045980 17304 rpc_server.cc:307] RPC server started. Bound to: 127.16.209.189:37189
14:30:13.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.046058 17376 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.209.189:37189 every 8 connection(s)
14:30:13.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.048986 17304 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/data/info.pb
14:30:13.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.053857 17222 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu as pid 17304
14:30:13.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.054345 17222 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-1/wal/instance
14:30:13.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.055263 17377 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:30:13.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.056707 17222 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:13.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:13.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/wal
14:30:13.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/data
14:30:13.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:30:13.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:30:13.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:30:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/logs
14:30:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/data/info.pb
14:30:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:30:13.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:30:13.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:30:13.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:30:13.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:13.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:13.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:13.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:30:13.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:30:13.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:30:13.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:30:13.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.188:34123
14:30:13.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.188
14:30:13.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:13.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:13.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:13.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:13.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:30:13.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:30:13.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:13.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:30:13.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33909/jwks.json with env {}
14:30:13.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.075057 17377 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } has no permanent_uuid. Determining permanent_uuid...
14:30:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.103663 17377 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } has no permanent_uuid. Determining permanent_uuid...
14:30:13.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.119187 17377 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } has no permanent_uuid. Determining permanent_uuid...
14:30:13.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.122025 17328 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.127125 17377 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.176725 17377 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 1
14:30:13.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.181015 17377 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.231545 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } attempt: 7
14:30:13.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.244450 17302 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } has no permanent_uuid. Determining permanent_uuid...
14:30:13.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.249392 17377 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 2
14:30:13.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.250814 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.254235 17377 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.309255 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 1
14:30:13.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.313989 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.345698 17377 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 3
14:30:13.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.350574 17377 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.395510 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 2
14:30:13.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.399905 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.400736 17379 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:30:13.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.401273 17379 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:30:13.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.401715 17379 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:30:13.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.437356 17379 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:30:13.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.437703 17379 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:30:13.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.437906 17379 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:30:13.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.438109 17379 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:30:13.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.438297 17379 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:30:13.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.438437 17379 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:33909/jwks.json
14:30:13.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.480638 17379 master_runner.cc:387] Master server non-default flags:
14:30:13.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/data
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/wal
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.188:34123
14:30:13.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:30:13.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:30:13.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:30:13.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33909/jwks.json
14:30:13.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:13.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:13.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/data/info.pb
14:30:13.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.188
14:30:13.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:13.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:30:13.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:13.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/logs
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 14:12:00 UTC on bdcb31816ec0
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16864
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.482102 17379 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:30:13.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.484328 17379 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:30:13.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.485366 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 3
14:30:13.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.489889 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.494016 17377 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 4
14:30:13.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.497648 17391 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:13.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.500168 17377 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.630394 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 4
14:30:13.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.637730 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.799708 17377 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 5
14:30:13.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.806963 17377 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:13.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:13.921291 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 5
14:30:13.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.928314 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:14.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.354576 17377 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 6
14:30:14.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:14.367764 17377 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:14.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.481536 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 6
14:30:14.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:14.492072 17302 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.209.188:34123: Network error: Client connection negotiation failed: client connection to 127.16.209.188:34123: connect: Connection refused (error 111)
14:30:14.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:13.499485 17392 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:14.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:14.755846 17379 thread.cc:641] GCE (cloud detector) Time spent creating pthread: real 1.260s	user 0.440s	sys 0.820s
14:30:14.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:14.756788 17379 thread.cc:608] GCE (cloud detector) Time spent starting thread: real 1.261s	user 0.440s	sys 0.820s
14:30:14.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.759181 17379 server_base.cc:1061] running on GCE node
14:30:14.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:14.760644 17400 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:14.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.762234 17379 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:30:14.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.765566 17379 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:30:14.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.767467 17379 hybrid_clock.cc:648] HybridClock initialized: now 1783521014767353 us; error 122 us; skew 500 ppm
14:30:14.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.768715 17379 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:30:14.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.777244 17379 webserver.cc:533] Webserver started at http://127.16.209.188:35901/ using document root <none> and password file <none>
14:30:14.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.778330 17379 fs_manager.cc:362] Metadata directory not provided
14:30:14.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.778589 17379 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:30:14.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.779191 17379 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:30:14.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.785843 17379 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/data/instance:
14:30:14.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "437f8bda2b6c4ce398ff7ed89f5641d6"
14:30:14.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:14 on dist-test-slave-kjw1"
14:30:14.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.787302 17379 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/wal/instance:
14:30:14.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "437f8bda2b6c4ce398ff7ed89f5641d6"
14:30:14.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:14 on dist-test-slave-kjw1"
14:30:14.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.796047 17379 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.003s	sys 0.004s
14:30:14.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.802994 17405 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:30:14.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.804452 17379 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.005s	sys 0.001s
14:30:14.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.804850 17379 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/data,/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/wal
14:30:14.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "437f8bda2b6c4ce398ff7ed89f5641d6"
14:30:14.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:14 on dist-test-slave-kjw1"
14:30:14.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.805274 17379 fs_report.cc:389] FS layout report
14:30:14.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:30:14.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/wal
14:30:14.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/wal
14:30:14.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/data/data
14:30:14.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:30:14.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:30:14.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:30:14.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:30:14.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:30:14.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:30:14.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:30:14.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:30:14.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:30:14.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:30:14.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:30:14.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.876200 17379 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:30:14.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.877812 17379 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:30:14.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.878319 17379 kserver.cc:163] Server-wide thread pool size limit: 3276
14:30:14.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.955197 17379 rpc_server.cc:307] RPC server started. Bound to: 127.16.209.188:34123
14:30:14.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.955292 17456 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.209.188:34123 every 8 connection(s)
14:30:14.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.958367 17379 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/data/info.pb
14:30:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.963882 17222 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu as pid 17379
14:30:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.964293 17222 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/master-2/wal/instance
14:30:14.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.966166 17457 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:30:14.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:14.982709 17457 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } has no permanent_uuid. Determining permanent_uuid...
14:30:15.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.006026 17457 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } has no permanent_uuid. Determining permanent_uuid...
14:30:15.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.017970 17457 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } has no permanent_uuid. Determining permanent_uuid...
14:30:15.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.035177 17457 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6: Bootstrap starting.
14:30:15.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.042686 17457 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6: Neither blocks nor log segments found. Creating new log.
14:30:15.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.045056 17457 log.cc:826] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6: Log is configured to *not* fsync() on all Append() calls
14:30:15.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.050791 17457 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6: No bootstrap required, opened a new log
14:30:15.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.073606 17457 raft_consensus.cc:359] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } }
14:30:15.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.074502 17457 raft_consensus.cc:385] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:30:15.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.074802 17457 raft_consensus.cc:740] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 437f8bda2b6c4ce398ff7ed89f5641d6, State: Initialized, Role: FOLLOWER
14:30:15.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.075574 17457 consensus_queue.cc:260] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [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: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } }
14:30:15.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.077863 17466 sys_catalog.cc:455] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [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: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } } }
14:30:15.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.078472 17466 sys_catalog.cc:458] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [sys.catalog]: This master's current role is: FOLLOWER
14:30:15.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.079046 17457 sys_catalog.cc:565] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [sys.catalog]: configured and running, proceeding with master startup.
14:30:15.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:15.106534 17477 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:30:15.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:15.106817 17477 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:30:15.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.101441 17379 master_runner.cc:187] Error getting master registration for 127.16.209.190:42029: OK, instance_id { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" instance_seqno: 1783521010827940 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:30:15.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.124640 17379 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:30:15.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:15.133769 17411 tablet.cc:2406] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:30:15.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.248274 17466 raft_consensus.cc:493] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:30:15.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.248904 17466 raft_consensus.cc:515] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } }
14:30:15.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.251672 17466 leader_election.cc:290] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 842194925e8446f7ab806a2e674fb77b (127.16.209.190:42029), 1efb1f2e0a644521a25881d4cb520b79 (127.16.209.189:37189)
14:30:15.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.428364 17377 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 7
14:30:15.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.452317 17377 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79: Bootstrap starting.
14:30:15.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.460219 17377 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79: Neither blocks nor log segments found. Creating new log.
14:30:15.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.462616 17377 log.cc:826] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79: Log is configured to *not* fsync() on all Append() calls
14:30:15.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.468225 17377 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79: No bootstrap required, opened a new log
14:30:15.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.494099 17377 raft_consensus.cc:359] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } }
14:30:15.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.495000 17377 raft_consensus.cc:385] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:30:15.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.495271 17377 raft_consensus.cc:740] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 1efb1f2e0a644521a25881d4cb520b79, State: Initialized, Role: FOLLOWER
14:30:15.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.496249 17377 consensus_queue.cc:260] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [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: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } }
14:30:15.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.499068 17481 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [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: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } } }
14:30:15.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.500166 17481 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [sys.catalog]: This master's current role is: FOLLOWER
14:30:15.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.500977 17377 sys_catalog.cc:565] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [sys.catalog]: configured and running, proceeding with master startup.
14:30:15.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.501202 17352 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1efb1f2e0a644521a25881d4cb520b79" is_pre_election: true
14:30:15.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.502084 17352 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 437f8bda2b6c4ce398ff7ed89f5641d6 in term 0.
14:30:15.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.503575 17407 leader_election.cc:304] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [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: 1efb1f2e0a644521a25881d4cb520b79, 437f8bda2b6c4ce398ff7ed89f5641d6; no voters: 
14:30:15.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.504784 17466 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [term 0 FOLLOWER]: Leader pre-election won for term 1
14:30:15.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.505187 17466 raft_consensus.cc:493] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:30:15.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.505554 17466 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [term 0 FOLLOWER]: Advancing to term 1
14:30:15.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.513984 17466 raft_consensus.cc:515] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } }
14:30:15.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.529944 17302 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } attempt: 7
14:30:15.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.540268 17352 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1efb1f2e0a644521a25881d4cb520b79"
14:30:15.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.540843 17352 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [term 0 FOLLOWER]: Advancing to term 1
14:30:15.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.541105 17466 leader_election.cc:290] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [CANDIDATE]: Term 1 election: Requested vote from peers 842194925e8446f7ab806a2e674fb77b (127.16.209.190:42029), 1efb1f2e0a644521a25881d4cb520b79 (127.16.209.189:37189)
14:30:15.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.548470 17352 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 437f8bda2b6c4ce398ff7ed89f5641d6 in term 1.
14:30:15.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.550406 17407 leader_election.cc:304] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [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: 1efb1f2e0a644521a25881d4cb520b79, 437f8bda2b6c4ce398ff7ed89f5641d6; no voters: 
14:30:15.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.551486 17466 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [term 1 FOLLOWER]: Leader election won for term 1
14:30:15.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.569419 17466 raft_consensus.cc:697] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [term 1 LEADER]: Becoming Leader. State: Replica: 437f8bda2b6c4ce398ff7ed89f5641d6, State: Running, Role: LEADER
14:30:15.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.571481 17466 consensus_queue.cc:237] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [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: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } }
14:30:15.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.580412 17302 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b: Bootstrap starting.
14:30:15.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.589550 17490 sys_catalog.cc:455] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 437f8bda2b6c4ce398ff7ed89f5641d6. Latest consensus state: current_term: 1 leader_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } } }
14:30:15.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.590291 17490 sys_catalog.cc:458] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [sys.catalog]: This master's current role is: LEADER
14:30:15.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.596361 17496 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
14:30:15.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.603334 17496 catalog_manager.cc:1520] Initializing Kudu cluster ID...
14:30:15.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.589470 17495 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
14:30:15.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.620316 17302 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b: Neither blocks nor log segments found. Creating new log.
14:30:15.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.628242 17302 log.cc:826] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b: Log is configured to *not* fsync() on all Append() calls
14:30:15.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.634027 17302 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b: No bootstrap required, opened a new log
14:30:15.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.594331 17304 master_runner.cc:187] Error getting master registration for 127.16.209.190:42029: OK, instance_id { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" instance_seqno: 1783521010827940 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:30:15.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.642485 17304 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:30:15.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.647280 17352 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [term 1 FOLLOWER]: Refusing update from remote peer 437f8bda2b6c4ce398ff7ed89f5641d6: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:30:15.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.649425 17490 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [LEADER]: Connected to new peer: Peer: permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:30:15.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.662873 17302 raft_consensus.cc:359] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } }
14:30:15.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.663757 17302 raft_consensus.cc:385] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:30:15.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.664072 17302 raft_consensus.cc:740] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 842194925e8446f7ab806a2e674fb77b, State: Initialized, Role: FOLLOWER
14:30:15.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.665076 17302 consensus_queue.cc:260] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [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: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } }
14:30:15.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.670264 17302 sys_catalog.cc:565] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [sys.catalog]: configured and running, proceeding with master startup.
14:30:15.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.670473 17276 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "842194925e8446f7ab806a2e674fb77b"
14:30:15.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.671147 17276 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [term 0 FOLLOWER]: Advancing to term 1
14:30:15.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.675108 17277 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "842194925e8446f7ab806a2e674fb77b" is_pre_election: true
14:30:15.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.685273 17481 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 437f8bda2b6c4ce398ff7ed89f5641d6. Latest consensus state: current_term: 1 leader_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } } }
14:30:15.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.686817 17276 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 437f8bda2b6c4ce398ff7ed89f5641d6 in term 1.
14:30:15.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.689026 17275 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [term 1 FOLLOWER]: Refusing update from remote peer 437f8bda2b6c4ce398ff7ed89f5641d6: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:30:15.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.690743 17481 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [sys.catalog]: This master's current role is: FOLLOWER
14:30:15.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.695838 17497 mvcc.cc:204] Tried to move back new op lower bound from 7305302080034045952 to 7305302079796576256. Current Snapshot: MvccSnapshot[applied={T|T < 7305302080034045952}]
14:30:15.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.699827 17499 mvcc.cc:204] Tried to move back new op lower bound from 7305302080034045952 to 7305302079796576256. Current Snapshot: MvccSnapshot[applied={T|T < 7305302080034045952}]
14:30:15.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.705358 17481 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } } }
14:30:15.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.705267 17466 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [LEADER]: Connected to new peer: Peer: permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
14:30:15.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.706092 17481 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79 [sys.catalog]: This master's current role is: FOLLOWER
14:30:15.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.669443 17500 sys_catalog.cc:455] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [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: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } } }
14:30:15.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.710999 17500 sys_catalog.cc:458] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [sys.catalog]: This master's current role is: FOLLOWER
14:30:15.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.720230 17490 sys_catalog.cc:455] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } } }
14:30:15.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.721696 17496 catalog_manager.cc:1383] Generated new cluster ID: bea48695ae614877bcb5b419497bc0eb
14:30:15.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.721885 17490 sys_catalog.cc:458] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [sys.catalog]: This master's current role is: LEADER
14:30:15.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.721992 17496 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
14:30:15.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.744504 17500 sys_catalog.cc:455] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [sys.catalog]: SysCatalogTable state changed. Reason: New leader 437f8bda2b6c4ce398ff7ed89f5641d6. Latest consensus state: current_term: 1 leader_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } } }
14:30:15.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.745237 17500 sys_catalog.cc:458] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [sys.catalog]: This master's current role is: FOLLOWER
14:30:15.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.746428 17512 sys_catalog.cc:455] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } } }
14:30:15.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.747193 17512 sys_catalog.cc:458] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b [sys.catalog]: This master's current role is: FOLLOWER
14:30:15.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.765780 17496 catalog_manager.cc:1406] Generated new certificate authority record
14:30:15.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.767902 17496 catalog_manager.cc:1540] Loading token signing keys...
14:30:15.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.755045 17508 sys_catalog.cc:455] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "842194925e8446f7ab806a2e674fb77b" member_type: VOTER last_known_addr { host: "127.16.209.190" port: 42029 } } peers { permanent_uuid: "1efb1f2e0a644521a25881d4cb520b79" member_type: VOTER last_known_addr { host: "127.16.209.189" port: 37189 } } peers { permanent_uuid: "437f8bda2b6c4ce398ff7ed89f5641d6" member_type: VOTER last_known_addr { host: "127.16.209.188" port: 34123 } } }
14:30:15.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.780047 17508 sys_catalog.cc:458] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6 [sys.catalog]: This master's current role is: LEADER
14:30:15.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.808720 17496 catalog_manager.cc:6070] T 00000000000000000000000000000000 P 437f8bda2b6c4ce398ff7ed89f5641d6: Generated new TSK 0
14:30:15.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.810158 17496 catalog_manager.cc:1550] Initializing in-progress tserver states...
14:30:15.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.833169 17520 catalog_manager.cc:1295] Loaded cluster ID: bea48695ae614877bcb5b419497bc0eb
14:30:15.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.833479 17520 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b: loading cluster ID for follower catalog manager: success
14:30:15.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.840839 17222 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:15.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:15.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/wal
14:30:15.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/data
14:30:15.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:30:15.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:30:15.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:30:15.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:15.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:15.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:15.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/logs
14:30:15.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/data/info.pb
14:30:15.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:15.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:30:15.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:30:15.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:30:15.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:30:15.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:15.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:15.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:15.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:30:15.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:30:15.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.129:0
14:30:15.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.209.129
14:30:15.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.129
14:30:15.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:15.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:15.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:15.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:15.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:15.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:30:15.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.844178 17520 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b: acquiring CA information for follower catalog manager: success
14:30:15.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:15.850030 17520 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 842194925e8446f7ab806a2e674fb77b: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:30:16.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:16.354801 17522 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:30:16.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:16.355489 17522 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:30:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:16.356220 17522 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:30:16.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:16.413899 17522 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:30:16.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:16.415473 17522 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.16.209.129
14:30:16.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:16.480655 17522 tablet_server_runner.cc:78] Tablet server non-default flags:
14:30:16.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:16.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:16.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/data
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/wal
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.129:0
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/data/info.pb
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.129
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:30:16.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.209.129
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/logs
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:30:16.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:30:16.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 14:12:00 UTC on bdcb31816ec0
14:30:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16864
14:30:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:30:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:16.486747 17522 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:30:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:16.489560 17522 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:30:16.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:16.509151 17528 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:16.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:16.631961 17495 catalog_manager.cc:1295] Loaded cluster ID: bea48695ae614877bcb5b419497bc0eb
14:30:16.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:16.632848 17495 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79: loading cluster ID for follower catalog manager: success
14:30:16.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:16.654341 17495 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79: acquiring CA information for follower catalog manager: success
14:30:16.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:16.682749 17495 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 1efb1f2e0a644521a25881d4cb520b79: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:30:19.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:17.911604 17527 debug-util.cc:398] Leaking SignalData structure 0x7b0800028000 after lost signal to thread 17522
14:30:19.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:19.513875 17527 kernel_stack_watchdog.cc:198] Thread 17522 stuck at /home/jenkins-slave/workspace/build_and_test@2/src/kudu/util/thread.cc:642 for 393ms:
14:30:19.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
14:30:19.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
14:30:19.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
14:30:19.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
14:30:19.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:19.520714 17522 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 3.005s	user 0.006s	sys 0.000s
14:30:19.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:19.521451 17522 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 3.006s	user 0.007s	sys 0.000s
14:30:19.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:19.521950 17530 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 3008 milliseconds
14:30:19.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:19.522939 17532 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:19.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:16.511263 17529 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:19.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.523423 17522 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
14:30:19.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.528234 17522 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:30:19.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.540179 17522 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:30:19.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.542135 17522 hybrid_clock.cc:648] HybridClock initialized: now 1783521019542055 us; error 91 us; skew 500 ppm
14:30:19.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.543594 17522 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:30:19.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.576407 17522 webserver.cc:533] Webserver started at http://127.16.209.129:41955/ using document root <none> and password file <none>
14:30:19.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.578083 17522 fs_manager.cc:362] Metadata directory not provided
14:30:19.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.578661 17522 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:30:19.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.579401 17522 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:30:19.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.587688 17522 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/data/instance:
14:30:19.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "527647682ce94857a023df51d6a3454f"
14:30:19.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:19 on dist-test-slave-kjw1"
14:30:19.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.590523 17522 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/wal/instance:
14:30:19.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "527647682ce94857a023df51d6a3454f"
14:30:19.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:19 on dist-test-slave-kjw1"
14:30:19.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.603652 17522 fs_manager.cc:696] Time spent creating directory manager: real 0.012s	user 0.008s	sys 0.000s
14:30:19.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.612478 17541 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:30:19.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.614677 17522 fs_manager.cc:730] Time spent opening block manager: real 0.006s	user 0.004s	sys 0.000s
14:30:19.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.615126 17522 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/data,/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/wal
14:30:19.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "527647682ce94857a023df51d6a3454f"
14:30:19.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:19 on dist-test-slave-kjw1"
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.615595 17522 fs_report.cc:389] FS layout report
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/wal
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/wal
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/data/data
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:30:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:30:19.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:30:19.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:30:19.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:30:19.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.689853 17522 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:30:19.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.691990 17522 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:30:19.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.692565 17522 kserver.cc:163] Server-wide thread pool size limit: 3276
14:30:19.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.696583 17522 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:30:19.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.702498 17522 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:30:19.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.702793 17522 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:30:19.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.703086 17522 ts_tablet_manager.cc:616] Registered 0 tablets
14:30:19.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.703542 17522 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.001s	sys 0.000s
14:30:19.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.950863 17522 rpc_server.cc:307] RPC server started. Bound to: 127.16.209.129:42931
14:30:19.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.950937 17653 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.209.129:42931 every 8 connection(s)
14:30:19.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.954532 17522 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/data/info.pb
14:30:19.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.955502 17222 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu as pid 17522
14:30:19.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.956115 17222 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-0/wal/instance
14:30:19.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:19.967783 17222 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:19.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/wal
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/data
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/logs
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/data/info.pb
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:30:19.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:30:19.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.130:0
14:30:19.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.209.130
14:30:19.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.130
14:30:19.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:19.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:19.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:19.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:19.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:19.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:30:20.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.061290 17656 heartbeater.cc:344] Connected to a master server at 127.16.209.189:37189
14:30:20.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.061774 17656 heartbeater.cc:461] Registering TS with master...
14:30:20.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.063031 17656 heartbeater.cc:507] Master 127.16.209.189:37189 requested a full tablet report, sending...
14:30:20.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.067999 17342 ts_manager.cc:194] Registered new tserver with Master: 527647682ce94857a023df51d6a3454f (127.16.209.129:42931)
14:30:20.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.069665 17659 heartbeater.cc:344] Connected to a master server at 127.16.209.190:42029
14:30:20.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.069989 17659 heartbeater.cc:461] Registering TS with master...
14:30:20.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.070844 17659 heartbeater.cc:507] Master 127.16.209.190:42029 requested a full tablet report, sending...
14:30:20.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.074719 17267 ts_manager.cc:194] Registered new tserver with Master: 527647682ce94857a023df51d6a3454f (127.16.209.129:42931)
14:30:20.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.081466 17654 heartbeater.cc:344] Connected to a master server at 127.16.209.188:34123
14:30:20.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.081821 17654 heartbeater.cc:461] Registering TS with master...
14:30:20.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.082769 17654 heartbeater.cc:507] Master 127.16.209.188:34123 requested a full tablet report, sending...
14:30:20.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.085443 17422 ts_manager.cc:194] Registered new tserver with Master: 527647682ce94857a023df51d6a3454f (127.16.209.129:42931)
14:30:20.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.088155 17422 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.16.209.129:57329
14:30:20.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:20.368224 17655 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:30:20.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:20.368669 17655 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:30:20.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:20.369153 17655 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:30:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:20.403550 17655 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:30:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:20.404400 17655 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.16.209.130
14:30:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.440846 17655 tablet_server_runner.cc:78] Tablet server non-default flags:
14:30:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:30:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/data
14:30:20.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/wal
14:30:20.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:20.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:20.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.130:0
14:30:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:30:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/data/info.pb
14:30:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.130
14:30:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:30:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:30:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.209.130
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/logs
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 14:12:00 UTC on bdcb31816ec0
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16864
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.442278 17655 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:30:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:20.443974 17655 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:30:20.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:20.459760 17670 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:21.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.092434 17654 heartbeater.cc:499] Master 127.16.209.188:34123 was elected leader, sending a full tablet report...
14:30:21.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:20.461452 17671 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:21.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:20.466269 17673 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:21.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:21.698309 17672 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
14:30:21.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.698331 17655 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
14:30:21.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.702649 17655 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:30:21.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.705600 17655 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:30:21.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.707104 17655 hybrid_clock.cc:648] HybridClock initialized: now 1783521021707050 us; error 56 us; skew 500 ppm
14:30:21.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.708389 17655 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:30:21.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.716675 17655 webserver.cc:533] Webserver started at http://127.16.209.130:33829/ using document root <none> and password file <none>
14:30:21.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.717765 17655 fs_manager.cc:362] Metadata directory not provided
14:30:21.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.718060 17655 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:30:21.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.718726 17655 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:30:21.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.724368 17655 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/data/instance:
14:30:21.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5e9021372d34430a8915804408d069eb"
14:30:21.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:21 on dist-test-slave-kjw1"
14:30:21.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.725737 17655 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/wal/instance:
14:30:21.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5e9021372d34430a8915804408d069eb"
14:30:21.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:21 on dist-test-slave-kjw1"
14:30:21.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.733830 17655 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.004s	sys 0.004s
14:30:21.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.740074 17681 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:30:21.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.741205 17655 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.001s
14:30:21.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.741672 17655 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/data,/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/wal
14:30:21.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5e9021372d34430a8915804408d069eb"
14:30:21.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:21 on dist-test-slave-kjw1"
14:30:21.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.742132 17655 fs_report.cc:389] FS layout report
14:30:21.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:30:21.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/wal
14:30:21.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/wal
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/data/data
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:30:21.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:30:21.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.807395 17655 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:30:21.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.809008 17655 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:30:21.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.809533 17655 kserver.cc:163] Server-wide thread pool size limit: 3276
14:30:21.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.812208 17655 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:30:21.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.816598 17655 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:30:21.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.816859 17655 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:30:21.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.817162 17655 ts_tablet_manager.cc:616] Registered 0 tablets
14:30:21.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:21.817366 17655 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:30:22.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.046109 17655 rpc_server.cc:307] RPC server started. Bound to: 127.16.209.130:40651
14:30:22.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.046448 17793 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.209.130:40651 every 8 connection(s)
14:30:22.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.050710 17655 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/data/info.pb
14:30:22.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.051549 17222 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu as pid 17655
14:30:22.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.052246 17222 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-1/wal/instance
14:30:22.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.067521 17222 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:22.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu
14:30:22.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/wal
14:30:22.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/data
14:30:22.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:30:22.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:30:22.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:30:22.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/logs
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/data/info.pb
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:30:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.131:0
14:30:22.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.209.131
14:30:22.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.131
14:30:22.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:22.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:22.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:22.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:22.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:22.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:30:22.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.140080 17794 heartbeater.cc:344] Connected to a master server at 127.16.209.188:34123
14:30:22.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.140595 17794 heartbeater.cc:461] Registering TS with master...
14:30:22.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.141870 17794 heartbeater.cc:507] Master 127.16.209.188:34123 requested a full tablet report, sending...
14:30:22.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.144454 17795 heartbeater.cc:344] Connected to a master server at 127.16.209.189:37189
14:30:22.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.144802 17795 heartbeater.cc:461] Registering TS with master...
14:30:22.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.145620 17422 ts_manager.cc:194] Registered new tserver with Master: 5e9021372d34430a8915804408d069eb (127.16.209.130:40651)
14:30:22.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.145691 17795 heartbeater.cc:507] Master 127.16.209.189:37189 requested a full tablet report, sending...
14:30:22.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.146100 17796 heartbeater.cc:344] Connected to a master server at 127.16.209.190:42029
14:30:22.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.146438 17796 heartbeater.cc:461] Registering TS with master...
14:30:22.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.147316 17796 heartbeater.cc:507] Master 127.16.209.190:42029 requested a full tablet report, sending...
14:30:22.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.147368 17422 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.16.209.130:59781
14:30:22.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.148532 17342 ts_manager.cc:194] Registered new tserver with Master: 5e9021372d34430a8915804408d069eb (127.16.209.130:40651)
14:30:22.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.150775 17267 ts_manager.cc:194] Registered new tserver with Master: 5e9021372d34430a8915804408d069eb (127.16.209.130:40651)
14:30:22.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:22.324177 17650 debug-util.cc:398] Leaking SignalData structure 0x7b08000ad3c0 after lost signal to thread 17523
14:30:22.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:22.325317 17650 debug-util.cc:398] Leaking SignalData structure 0x7b08000b3580 after lost signal to thread 17653
14:30:22.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:22.563987 17799 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:30:22.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:22.564517 17799 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:30:22.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:22.565124 17799 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:30:22.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:22.600669 17799 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:30:22.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:22.601773 17799 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.16.209.131
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.650820 17799 tablet_server_runner.cc:78] Tablet server non-default flags:
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.209.148:33071
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/data
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/wal
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.209.131:0
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:30:22.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/data/info.pb
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.209.131
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.209.190:42029,127.16.209.189:37189,127.16.209.188:34123
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.209.131
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/logs
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 14:12:00 UTC on bdcb31816ec0
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16864
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:30:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.652639 17799 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:30:22.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:22.654433 17799 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:30:22.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:22.671535 17810 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:23.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:23.152534 17794 heartbeater.cc:499] Master 127.16.209.188:34123 was elected leader, sending a full tablet report...
14:30:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:24.074851 17809 debug-util.cc:398] Leaking SignalData structure 0x7b0800028000 after lost signal to thread 17799
14:30:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:24.468954 17809 kernel_stack_watchdog.cc:198] Thread 17799 stuck at /home/jenkins-slave/workspace/build_and_test@2/src/kudu/util/thread.cc:642 for 397ms:
14:30:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
14:30:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
14:30:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
14:30:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
14:30:24.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:24.470399 17799 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.797s	user 0.000s	sys 0.002s
14:30:24.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:24.470803 17799 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.797s	user 0.000s	sys 0.002s
14:30:24.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:22.672591 17811 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:24.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:24.474336 17813 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:30:24.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:24.477380 17812 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1798 milliseconds
14:30:24.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.477479 17799 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
14:30:24.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.479087 17799 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:30:24.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.482059 17799 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:30:24.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.483829 17799 hybrid_clock.cc:648] HybridClock initialized: now 1783521024483780 us; error 46 us; skew 500 ppm
14:30:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.485028 17799 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:30:24.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.499492 17799 webserver.cc:533] Webserver started at http://127.16.209.131:33257/ using document root <none> and password file <none>
14:30:24.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.500844 17799 fs_manager.cc:362] Metadata directory not provided
14:30:24.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.501139 17799 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:30:24.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.501721 17799 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:30:24.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.509049 17799 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/data/instance:
14:30:24.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d76f8bd455ca4772ba3b02fdcbce7a68"
14:30:24.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:24 on dist-test-slave-kjw1"
14:30:24.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.510618 17799 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/wal/instance:
14:30:24.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d76f8bd455ca4772ba3b02fdcbce7a68"
14:30:24.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:24 on dist-test-slave-kjw1"
14:30:24.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.520788 17799 fs_manager.cc:696] Time spent creating directory manager: real 0.009s	user 0.011s	sys 0.001s
14:30:24.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.528761 17821 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:30:24.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.530278 17799 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.001s	sys 0.003s
14:30:24.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.530697 17799 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/data,/tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/wal
14:30:24.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d76f8bd455ca4772ba3b02fdcbce7a68"
14:30:24.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:30:24 on dist-test-slave-kjw1"
14:30:24.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.531152 17799 fs_report.cc:389] FS layout report
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/wal
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/wal
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/data/data
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:30:24.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:30:24.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.645054 17799 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:30:24.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.646694 17799 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:30:24.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.647572 17799 kserver.cc:163] Server-wide thread pool size limit: 3276
14:30:24.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.651283 17799 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:30:24.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.656380 17799 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:30:24.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.656632 17799 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:30:24.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.656945 17799 ts_tablet_manager.cc:616] Registered 0 tablets
14:30:24.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.657148 17799 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:30:24.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.902856 17799 rpc_server.cc:307] RPC server started. Bound to: 127.16.209.131:41913
14:30:24.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.903441 17933 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.209.131:41913 every 8 connection(s)
14:30:24.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.907060 17799 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/data/info.pb
14:30:24.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.907971 17222 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu as pid 17799
14:30:24.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.908408 17222 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskK2dDP_/test-tmp/mini-kudu-cluster7089163106429689854/ts-2/wal/instance
14:30:24.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.980764 17935 heartbeater.cc:344] Connected to a master server at 127.16.209.189:37189
14:30:24.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.981274 17935 heartbeater.cc:461] Registering TS with master...
14:30:24.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.982640 17935 heartbeater.cc:507] Master 127.16.209.189:37189 requested a full tablet report, sending...
14:30:24.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.982872 17934 heartbeater.cc:344] Connected to a master server at 127.16.209.188:34123
14:30:24.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.983256 17934 heartbeater.cc:461] Registering TS with master...
14:30:24.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.984221 17934 heartbeater.cc:507] Master 127.16.209.188:34123 requested a full tablet report, sending...
14:30:24.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.986696 17342 ts_manager.cc:194] Registered new tserver with Master: d76f8bd455ca4772ba3b02fdcbce7a68 (127.16.209.131:41913)
14:30:24.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.989406 17422 ts_manager.cc:194] Registered new tserver with Master: d76f8bd455ca4772ba3b02fdcbce7a68 (127.16.209.131:41913)
14:30:24.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.992146 17422 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.16.209.131:55221
14:30:24.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.992432 17940 heartbeater.cc:344] Connected to a master server at 127.16.209.190:42029
14:30:24.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.992854 17940 heartbeater.cc:461] Registering TS with master...
14:30:24.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:24.996156 17940 heartbeater.cc:507] Master 127.16.209.190:42029 requested a full tablet report, sending...
14:30:25.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:25.000020 17267 ts_manager.cc:194] Registered new tserver with Master: d76f8bd455ca4772ba3b02fdcbce7a68 (127.16.209.131:41913)
14:30:25.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:25.019032 17222 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
14:30:25.032 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:30:25.033 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

14:30:25.044 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.16.209.190"
      port: 42029
    }
    bound_http_address {
      host: "127.16.209.190"
      port: 34559
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.16.209.189"
      port: 37189
    }
    bound_http_address {
      host: "127.16.209.189"
      port: 36505
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.16.209.188"
      port: 34123
    }
    bound_http_address {
      host: "127.16.209.188"
      port: 35901
    }
  }
}

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

14:30:25.051 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.16.209.129"
      port: 42931
    }
    bound_http_address {
      host: "127.16.209.129"
      port: 41955
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.16.209.130"
      port: 40651
    }
    bound_http_address {
      host: "127.16.209.130"
      port: 33829
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.16.209.131"
      port: 41913
    }
    bound_http_address {
      host: "127.16.209.131"
      port: 33257
    }
  }
}

14:30:25.052 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
14:30:25.299 [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)
14:30:25.361 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
14:30:25.511 [DEBUG - main] (Connection.java:748) [peer master-127.16.209.189:37189(127.16.209.189:37189)] connecting to peer
14:30:25.568 [DEBUG - main] (Connection.java:748) [peer master-127.16.209.190:42029(127.16.209.190:42029)] connecting to peer
14:30:25.570 [DEBUG - main] (Connection.java:748) [peer master-127.16.209.188:34123(127.16.209.188:34123)] connecting to peer
14:30:25.588 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.16.209.188:34123(127.16.209.188:34123)] Successfully connected to peer
14:30:25.592 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.16.209.189:37189(127.16.209.189:37189)] Successfully connected to peer
14:30:25.593 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.16.209.190:42029(127.16.209.190:42029)] Successfully connected to peer
14:30:25.694 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.16.209.189
14:30:25.694 [DEBUG - kudu-nio-2] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.16.209.188
14:30:25.694 [DEBUG - kudu-nio-1] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.16.209.190
14:30:25.929 [DEBUG - kudu-nio-2] (Negotiator.java:918) Authenticated connection [id: 0xf7a69211, L:/127.0.0.1:35754 - R:/127.16.209.188:34123] using SASL/PLAIN
14:30:25.929 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0x6a4690d4, L:/127.0.0.1:35496 - R:/127.16.209.189:37189] using SASL/PLAIN
14:30:25.929 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0x83996b5f, L:/127.0.0.1:35170 - R:/127.16.209.190:42029] using SASL/PLAIN
14:30:25.972 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:30:25.974 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=505), Traces: [0ms] refreshing cache from master, [28ms] Sub RPC ConnectToMaster: sending RPC to server master-127.16.209.189:37189, [96ms] Sub RPC ConnectToMaster: sending RPC to server master-127.16.209.190:42029, [98ms] Sub RPC ConnectToMaster: sending RPC to server master-127.16.209.188:34123, [474ms] Sub RPC ConnectToMaster: received response from server master-127.16.209.190:42029: OK, [474ms] Sub RPC ConnectToMaster: received response from server master-127.16.209.189:37189: OK, [474ms] Sub RPC ConnectToMaster: received response from server master-127.16.209.188:34123: OK, deferred=null) after lookup
14:30:25.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:25.996541 17934 heartbeater.cc:499] Master 127.16.209.188:34123 was elected leader, sending a full tablet report...
14:30:26.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.039199 17422 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:35754:
14:30:26.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783521008195"
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:30:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:30:26.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:30:26.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:26.044106 17422 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-1783521008195 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
14:30:26.143 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:894) Opened table afb01d0f2b534443aae1dee6ebb4a05c
14:30:26.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.158062 17589 tablet_service.cc:1511] Processing CreateTablet for tablet 35b8627149eb48498534cd1a09829f8f (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783521008195 [id=afb01d0f2b534443aae1dee6ebb4a05c]), partition=RANGE (key) PARTITION UNBOUNDED
14:30:26.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.160130 17589 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 35b8627149eb48498534cd1a09829f8f. 1 dirs total, 0 dirs full, 0 dirs failed
14:30:26.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.205897 17967 tablet_bootstrap.cc:492] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f: Bootstrap starting.
14:30:26.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.207953 17729 tablet_service.cc:1511] Processing CreateTablet for tablet 35b8627149eb48498534cd1a09829f8f (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783521008195 [id=afb01d0f2b534443aae1dee6ebb4a05c]), partition=RANGE (key) PARTITION UNBOUNDED
14:30:26.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.210101 17729 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 35b8627149eb48498534cd1a09829f8f. 1 dirs total, 0 dirs full, 0 dirs failed
14:30:26.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.210178 17869 tablet_service.cc:1511] Processing CreateTablet for tablet 35b8627149eb48498534cd1a09829f8f (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783521008195 [id=afb01d0f2b534443aae1dee6ebb4a05c]), partition=RANGE (key) PARTITION UNBOUNDED
14:30:26.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.212040 17869 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 35b8627149eb48498534cd1a09829f8f. 1 dirs total, 0 dirs full, 0 dirs failed
14:30:26.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.219363 17967 tablet_bootstrap.cc:654] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f: Neither blocks nor log segments found. Creating new log.
14:30:26.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.223161 17967 log.cc:826] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f: Log is configured to *not* fsync() on all Append() calls
14:30:26.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.230104 17967 tablet_bootstrap.cc:492] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f: No bootstrap required, opened a new log
14:30:26.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.230624 17967 ts_tablet_manager.cc:1403] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f: Time spent bootstrapping tablet: real 0.025s	user 0.017s	sys 0.002s
14:30:26.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.243296 17969 tablet_bootstrap.cc:492] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68: Bootstrap starting.
14:30:26.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.251957 17969 tablet_bootstrap.cc:654] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68: Neither blocks nor log segments found. Creating new log.
14:30:26.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.254555 17969 log.cc:826] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68: Log is configured to *not* fsync() on all Append() calls
14:30:26.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.254717 17970 tablet_bootstrap.cc:492] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb: Bootstrap starting.
14:30:26.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.260629 17969 tablet_bootstrap.cc:492] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68: No bootstrap required, opened a new log
14:30:26.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.261142 17969 ts_tablet_manager.cc:1403] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68: Time spent bootstrapping tablet: real 0.019s	user 0.005s	sys 0.013s
14:30:26.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.263149 17970 tablet_bootstrap.cc:654] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb: Neither blocks nor log segments found. Creating new log.
14:30:26.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.264787 17967 raft_consensus.cc:359] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "527647682ce94857a023df51d6a3454f" member_type: VOTER last_known_addr { host: "127.16.209.129" port: 42931 } } peers { permanent_uuid: "5e9021372d34430a8915804408d069eb" member_type: VOTER last_known_addr { host: "127.16.209.130" port: 40651 } } peers { permanent_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" member_type: VOTER last_known_addr { host: "127.16.209.131" port: 41913 } }
14:30:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.265667 17967 raft_consensus.cc:385] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:30:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.265982 17967 raft_consensus.cc:740] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 527647682ce94857a023df51d6a3454f, State: Initialized, Role: FOLLOWER
14:30:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.266970 17967 consensus_queue.cc:260] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f [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: "527647682ce94857a023df51d6a3454f" member_type: VOTER last_known_addr { host: "127.16.209.129" port: 42931 } } peers { permanent_uuid: "5e9021372d34430a8915804408d069eb" member_type: VOTER last_known_addr { host: "127.16.209.130" port: 40651 } } peers { permanent_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" member_type: VOTER last_known_addr { host: "127.16.209.131" port: 41913 } }
14:30:26.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.267612 17970 log.cc:826] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb: Log is configured to *not* fsync() on all Append() calls
14:30:26.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.277113 17967 ts_tablet_manager.cc:1434] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f: Time spent starting tablet: real 0.046s	user 0.035s	sys 0.008s
14:30:26.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.280681 17970 tablet_bootstrap.cc:492] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb: No bootstrap required, opened a new log
14:30:26.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.281636 17970 ts_tablet_manager.cc:1403] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb: Time spent bootstrapping tablet: real 0.028s	user 0.013s	sys 0.010s
14:30:26.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:26.291040 17664 tablet.cc:2406] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:30:26.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.299948 17969 raft_consensus.cc:359] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "527647682ce94857a023df51d6a3454f" member_type: VOTER last_known_addr { host: "127.16.209.129" port: 42931 } } peers { permanent_uuid: "5e9021372d34430a8915804408d069eb" member_type: VOTER last_known_addr { host: "127.16.209.130" port: 40651 } } peers { permanent_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" member_type: VOTER last_known_addr { host: "127.16.209.131" port: 41913 } }
14:30:26.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.300712 17969 raft_consensus.cc:385] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:30:26.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.300967 17969 raft_consensus.cc:740] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: d76f8bd455ca4772ba3b02fdcbce7a68, State: Initialized, Role: FOLLOWER
14:30:26.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.302224 17969 consensus_queue.cc:260] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [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: "527647682ce94857a023df51d6a3454f" member_type: VOTER last_known_addr { host: "127.16.209.129" port: 42931 } } peers { permanent_uuid: "5e9021372d34430a8915804408d069eb" member_type: VOTER last_known_addr { host: "127.16.209.130" port: 40651 } } peers { permanent_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" member_type: VOTER last_known_addr { host: "127.16.209.131" port: 41913 } }
14:30:26.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.306484 17969 ts_tablet_manager.cc:1434] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68: Time spent starting tablet: real 0.045s	user 0.021s	sys 0.013s
14:30:26.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.326325 17970 raft_consensus.cc:359] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "527647682ce94857a023df51d6a3454f" member_type: VOTER last_known_addr { host: "127.16.209.129" port: 42931 } } peers { permanent_uuid: "5e9021372d34430a8915804408d069eb" member_type: VOTER last_known_addr { host: "127.16.209.130" port: 40651 } } peers { permanent_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" member_type: VOTER last_known_addr { host: "127.16.209.131" port: 41913 } }
14:30:26.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.327044 17970 raft_consensus.cc:385] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:30:26.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.327347 17970 raft_consensus.cc:740] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 5e9021372d34430a8915804408d069eb, State: Initialized, Role: FOLLOWER
14:30:26.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.328258 17970 consensus_queue.cc:260] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb [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: "527647682ce94857a023df51d6a3454f" member_type: VOTER last_known_addr { host: "127.16.209.129" port: 42931 } } peers { permanent_uuid: "5e9021372d34430a8915804408d069eb" member_type: VOTER last_known_addr { host: "127.16.209.130" port: 40651 } } peers { permanent_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" member_type: VOTER last_known_addr { host: "127.16.209.131" port: 41913 } }
14:30:26.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.331974 17970 ts_tablet_manager.cc:1434] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb: Time spent starting tablet: real 0.050s	user 0.037s	sys 0.007s
14:30:26.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.345676 17974 raft_consensus.cc:493] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:30:26.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.346119 17974 raft_consensus.cc:515] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "527647682ce94857a023df51d6a3454f" member_type: VOTER last_known_addr { host: "127.16.209.129" port: 42931 } } peers { permanent_uuid: "5e9021372d34430a8915804408d069eb" member_type: VOTER last_known_addr { host: "127.16.209.130" port: 40651 } } peers { permanent_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" member_type: VOTER last_known_addr { host: "127.16.209.131" port: 41913 } }
14:30:26.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.351878 17974 leader_election.cc:290] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 527647682ce94857a023df51d6a3454f (127.16.209.129:42931), 5e9021372d34430a8915804408d069eb (127.16.209.130:40651)
14:30:26.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.368373 17609 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "35b8627149eb48498534cd1a09829f8f" candidate_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "527647682ce94857a023df51d6a3454f" is_pre_election: true
14:30:26.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.369928 17609 raft_consensus.cc:2468] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate d76f8bd455ca4772ba3b02fdcbce7a68 in term 0.
14:30:26.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.370054 17749 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "35b8627149eb48498534cd1a09829f8f" candidate_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5e9021372d34430a8915804408d069eb" is_pre_election: true
14:30:26.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.370877 17749 raft_consensus.cc:2468] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate d76f8bd455ca4772ba3b02fdcbce7a68 in term 0.
14:30:26.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.372146 17825 leader_election.cc:304] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [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: 527647682ce94857a023df51d6a3454f, d76f8bd455ca4772ba3b02fdcbce7a68; no voters: 
14:30:26.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.373028 17974 raft_consensus.cc:2804] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [term 0 FOLLOWER]: Leader pre-election won for term 1
14:30:26.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.373379 17974 raft_consensus.cc:493] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:30:26.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.373669 17974 raft_consensus.cc:3060] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [term 0 FOLLOWER]: Advancing to term 1
14:30:26.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:26.377882 17802 tablet.cc:2406] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:30:26.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.379279 17974 raft_consensus.cc:515] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "527647682ce94857a023df51d6a3454f" member_type: VOTER last_known_addr { host: "127.16.209.129" port: 42931 } } peers { permanent_uuid: "5e9021372d34430a8915804408d069eb" member_type: VOTER last_known_addr { host: "127.16.209.130" port: 40651 } } peers { permanent_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" member_type: VOTER last_known_addr { host: "127.16.209.131" port: 41913 } }
14:30:26.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.381023 17974 leader_election.cc:290] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [CANDIDATE]: Term 1 election: Requested vote from peers 527647682ce94857a023df51d6a3454f (127.16.209.129:42931), 5e9021372d34430a8915804408d069eb (127.16.209.130:40651)
14:30:26.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.382179 17609 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "35b8627149eb48498534cd1a09829f8f" candidate_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "527647682ce94857a023df51d6a3454f"
14:30:26.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.382382 17749 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "35b8627149eb48498534cd1a09829f8f" candidate_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5e9021372d34430a8915804408d069eb"
14:30:26.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.382632 17609 raft_consensus.cc:3060] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f [term 0 FOLLOWER]: Advancing to term 1
14:30:26.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.382882 17749 raft_consensus.cc:3060] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb [term 0 FOLLOWER]: Advancing to term 1
14:30:26.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.388662 17609 raft_consensus.cc:2468] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate d76f8bd455ca4772ba3b02fdcbce7a68 in term 1.
14:30:26.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.389667 17749 raft_consensus.cc:2468] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate d76f8bd455ca4772ba3b02fdcbce7a68 in term 1.
14:30:26.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.389801 17825 leader_election.cc:304] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [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: 527647682ce94857a023df51d6a3454f, d76f8bd455ca4772ba3b02fdcbce7a68; no voters: 
14:30:26.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.390830 17974 raft_consensus.cc:2804] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [term 1 FOLLOWER]: Leader election won for term 1
14:30:26.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.393098 17974 raft_consensus.cc:697] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [term 1 LEADER]: Becoming Leader. State: Replica: d76f8bd455ca4772ba3b02fdcbce7a68, State: Running, Role: LEADER
14:30:26.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.394188 17974 consensus_queue.cc:237] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [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: "527647682ce94857a023df51d6a3454f" member_type: VOTER last_known_addr { host: "127.16.209.129" port: 42931 } } peers { permanent_uuid: "5e9021372d34430a8915804408d069eb" member_type: VOTER last_known_addr { host: "127.16.209.130" port: 40651 } } peers { permanent_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" member_type: VOTER last_known_addr { host: "127.16.209.131" port: 41913 } }
14:30:26.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.408322 17421 catalog_manager.cc:5697] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 reported cstate change: term changed from 0 to 1, leader changed from <none> to d76f8bd455ca4772ba3b02fdcbce7a68 (127.16.209.131). New cstate: current_term: 1 leader_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "527647682ce94857a023df51d6a3454f" member_type: VOTER last_known_addr { host: "127.16.209.129" port: 42931 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "5e9021372d34430a8915804408d069eb" member_type: VOTER last_known_addr { host: "127.16.209.130" port: 40651 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "d76f8bd455ca4772ba3b02fdcbce7a68" member_type: VOTER last_known_addr { host: "127.16.209.131" port: 41913 } health_report { overall_health: HEALTHY } } }
14:30:26.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:30:26.449620 17941 tablet.cc:2406] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:30:26.535 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet 35b8627149eb48498534cd1a09829f8f for table 'org.apache.kudu.client.TestHybridTime-1783521008195' with partition [<start>, <end>)
14:30:26.544 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299991, tablet=35b8627149eb48498534cd1a09829f8f@[527647682ce94857a023df51d6a3454f(127.16.209.129:42931),5e9021372d34430a8915804408d069eb(127.16.209.130:40651),d76f8bd455ca4772ba3b02fdcbce7a68(127.16.209.131:41913)[L]]}]
14:30:26.545 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=20), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.16.209.188:34123, [9ms] Sub RPC GetTableLocations: received response from server master-127.16.209.188:34123: OK, deferred=null) after lookup
14:30:26.555 [DEBUG - kudu-nio-2] (Connection.java:748) [peer d76f8bd455ca4772ba3b02fdcbce7a68(127.16.209.131:41913)] connecting to peer
14:30:26.558 [DEBUG - kudu-nio-3] (Connection.java:757) [peer d76f8bd455ca4772ba3b02fdcbce7a68(127.16.209.131:41913)] Successfully connected to peer
14:30:26.636 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0x0e3c221a, L:/127.0.0.1:39772 - R:/127.16.209.131:41913] using TOKEN/null
14:30:26.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.656908 17749 raft_consensus.cc:1275] T 35b8627149eb48498534cd1a09829f8f P 5e9021372d34430a8915804408d069eb [term 1 FOLLOWER]: Refusing update from remote peer d76f8bd455ca4772ba3b02fdcbce7a68: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:30:26.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.658185 17609 raft_consensus.cc:1275] T 35b8627149eb48498534cd1a09829f8f P 527647682ce94857a023df51d6a3454f [term 1 FOLLOWER]: Refusing update from remote peer d76f8bd455ca4772ba3b02fdcbce7a68: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:30:26.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.660513 17979 consensus_queue.cc:1048] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [LEADER]: Connected to new peer: Peer: permanent_uuid: "5e9021372d34430a8915804408d069eb" member_type: VOTER last_known_addr { host: "127.16.209.130" port: 40651 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
14:30:26.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.661650 17974 consensus_queue.cc:1048] T 35b8627149eb48498534cd1a09829f8f P d76f8bd455ca4772ba3b02fdcbce7a68 [LEADER]: Connected to new peer: Peer: permanent_uuid: "527647682ce94857a023df51d6a3454f" member_type: VOTER last_known_addr { host: "127.16.209.129" port: 42931 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
14:30:26.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:26.717052 17983 mvcc.cc:204] Tried to move back new op lower bound from 7305302125165469696 to 7305302124118605824. Current Snapshot: MvccSnapshot[applied={T|T < 7305302125165469696}]
14:30:26.814 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:30:26.839 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:30:26.866 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:30:26.870 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@403825072(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:30:26.913 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:30:26.914 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1606929311(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:30:26.935 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:30:26.936 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@961389184(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:30:26.955 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:30:27.038 [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-1783521008195, tablet=35b8627149eb48498534cd1a09829f8f, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:30:27.054 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305302145645469697) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783521008195, tablet=35b8627149eb48498534cd1a09829f8f, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:30:27.066 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305302145645469701) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783521008195, tablet=35b8627149eb48498534cd1a09829f8f, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:30:27.083 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305302145645469705) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783521008195, tablet=35b8627149eb48498534cd1a09829f8f, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:30:27.100 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305302145645469710) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783521008195, tablet=35b8627149eb48498534cd1a09829f8f, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:30:27.118 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305302145645469714) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783521008195, tablet=35b8627149eb48498534cd1a09829f8f, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:30:27.133 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305302145645469719) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783521008195, tablet=35b8627149eb48498534cd1a09829f8f, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:30:27.148 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305302145645469720) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783521008195, tablet=35b8627149eb48498534cd1a09829f8f, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:30:27.152 [DEBUG - main] (Connection.java:575) [peer master-127.16.209.189:37189(127.16.209.189:37189)] disconnecting while in state READY
14:30:27.153 [DEBUG - main] (Connection.java:575) [peer master-127.16.209.188:34123(127.16.209.188:34123)] disconnecting while in state READY
14:30:27.153 [DEBUG - main] (Connection.java:575) [peer master-127.16.209.190:42029(127.16.209.190:42029)] disconnecting while in state READY
14:30:27.154 [DEBUG - main] (Connection.java:575) [peer d76f8bd455ca4772ba3b02fdcbce7a68(127.16.209.131:41913)] disconnecting while in state READY
14:30:27.159 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:30:27.161 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.16.209.190:42029(127.16.209.190:42029)] handling channelInactive
14:30:27.161 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.16.209.189:37189(127.16.209.189:37189)] handling channelInactive
14:30:27.161 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.16.209.188:34123(127.16.209.188:34123)] handling channelInactive
14:30:27.162 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.16.209.190:42029(127.16.209.190:42029)] cleaning up while in state READY due to: connection closed
14:30:27.162 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.16.209.188:34123(127.16.209.188:34123)] cleaning up while in state READY due to: connection closed
14:30:27.163 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.16.209.189:37189(127.16.209.189:37189)] cleaning up while in state READY due to: connection closed
14:30:27.166 [DEBUG - kudu-nio-3] (Connection.java:239) [peer d76f8bd455ca4772ba3b02fdcbce7a68(127.16.209.131:41913)] handling channelInactive
14:30:27.166 [DEBUG - kudu-nio-3] (Connection.java:709) [peer d76f8bd455ca4772ba3b02fdcbce7a68(127.16.209.131:41913)] cleaning up while in state READY due to: connection closed
14:30:27.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:27.167029 17222 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu with pid 17522
14:30:27.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:27.206004 17222 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu with pid 17655
14:30:27.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:27.244114 17222 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu with pid 17799
14:30:27.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:27.273041 17222 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu with pid 17234
14:30:27.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:27.303397 17222 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu with pid 17304
14:30:27.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:30:27.330829 17222 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskK2dDP_/build/tsan/bin/kudu with pid 17379
14:30:28.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T14:30:28Z chronyd exiting

Time: 21.281

OK (1 test)

