JUnit version 4.13.2
.20:03:02.938 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1786478582928
20:03:02.964 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
20:03:03.031 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
20:03:03.041 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskOcLkUh/test-tmp
20:03:03.047 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
20:03:03.050 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskOcLkUh/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
20:03:03.328 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

20:03:03.520 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
20:03:03.522 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

20:03:03.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:03.526235 11556 mini_oidc.cc:150] Starting JWKS server
20:03:03.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:03.530685 11556 webserver.cc:533] Webserver started at http://127.0.0.1:35157/ using document root <none> and password file <none>
20:03:03.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:03.531148 11556 mini_oidc.cc:186] Starting OIDC Discovery server
20:03:03.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:03.533313 11556 webserver.cc:533] Webserver started at http://127.0.0.1:46549/ using document root <none> and password file <none>
20:03:03.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T20:03:03Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
20:03:03.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T20:03:03Z Disabled control of system clock
20:03:03.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:03.604533 11556 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:03.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:03.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/wal
20:03:03.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/data
20:03:03.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:03.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:03.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:03.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:03.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:03.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:03.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/logs
20:03:03.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/data/info.pb
20:03:03.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:03.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:03.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:03.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:03.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:03.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:03.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:03.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:03.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
20:03:03.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:03.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:03:03.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:03:03.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.62:41783
20:03:03.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.62
20:03:03.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:03:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:03:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35157/jwks.json with env {}
20:03:03.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:03.945200 11568 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:03.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:03.945813 11568 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:03.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:03.946646 11568 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:03.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:03.981364 11568 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
20:03:03.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:03.981681 11568 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:03.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:03.981902 11568 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
20:03:03.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:03.982095 11568 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
20:03:03.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:03.982277 11568 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
20:03:03.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:03.982448 11568 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:35157/jwks.json
20:03:04.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:04.023017 11568 master_runner.cc:387] Master server non-default flags:
20:03:04.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/logs
20:03:04.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:04.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:04.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:04.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:04.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:04.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:04.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/data
20:03:04.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/wal
20:03:04.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:03:04.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:04.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:04.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:04.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:03:04.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.62:41783
20:03:04.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:03:04.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:04.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:03:04.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35157/jwks.json
20:03:04.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:04.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:04.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/data/info.pb
20:03:04.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.62
20:03:04.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:04.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:04.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:04.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:04.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:04.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:04.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:04.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
20:03:04.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:04.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 12dab910780628d7c8d59e0ab03bf2fa661d310d
20:03:04.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:03:04.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 19:45:48 UTC on e7f111948823
20:03:04.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13295
20:03:04.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:03:04.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:04.024530 11568 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:04.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:04.026602 11568 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:04.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:04.040629 11574 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
20:03:05.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:04.047434 11578 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
20:03:05.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:04.041929 11575 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
20:03:05.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.296248 11577 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
20:03:05.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.296876 11568 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
20:03:05.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.301271 11568 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:05.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.305078 11568 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:05.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.306550 11568 hybrid_clock.cc:648] HybridClock initialized: now 1786478585306525 us; error 75 us; skew 500 ppm
20:03:05.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.307585 11568 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:03:05.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.314608 11568 webserver.cc:533] Webserver started at http://127.11.73.62:39753/ using document root <none> and password file <none>
20:03:05.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.315817 11568 fs_manager.cc:362] Metadata directory not provided
20:03:05.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.316027 11568 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:05.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.316541 11568 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:05.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.321362 11568 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/data/instance:
20:03:05.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "323732fdc41141d8ad38ea835d703162"
20:03:05.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:05 on dist-test-slave-zpfg"
20:03:05.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.322781 11568 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/wal/instance:
20:03:05.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "323732fdc41141d8ad38ea835d703162"
20:03:05.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:05 on dist-test-slave-zpfg"
20:03:05.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.331775 11568 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.003s	sys 0.005s
20:03:05.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.338466 11586 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:05.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.339891 11568 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.003s	sys 0.001s
20:03:05.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.340231 11568 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/data,/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/wal
20:03:05.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "323732fdc41141d8ad38ea835d703162"
20:03:05.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:05 on dist-test-slave-zpfg"
20:03:05.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.340687 11568 fs_report.cc:389] FS layout report
20:03:05.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:05.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/wal
20:03:05.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/wal
20:03:05.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/data/data
20:03:05.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:05.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:05.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:05.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:05.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:05.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:05.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:05.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:05.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:05.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:05.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:05.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.411245 11568 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:05.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.412813 11568 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
20:03:05.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.413259 11568 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:05.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.497499 11568 rpc_server.cc:307] RPC server started. Bound to: 127.11.73.62:41783
20:03:05.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.497624 11641 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.11.73.62:41783 every 8 connection(s)
20:03:05.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.501020 11568 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/data/info.pb
20:03:05.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.508298 11642 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:05.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.510584 11556 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu as pid 11568
20:03:05.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.511184 11556 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-0/wal/instance
20:03:05.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.516800 11556 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:05.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:05.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/wal
20:03:05.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/data
20:03:05.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:05.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:05.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:05.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/logs
20:03:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/data/info.pb
20:03:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
20:03:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:03:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:03:05.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.61:40409
20:03:05.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.61
20:03:05.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:05.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:05.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:05.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:05.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:05.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:03:05.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:05.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:03:05.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35157/jwks.json with env {}
20:03:05.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.525796 11642 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } has no permanent_uuid. Determining permanent_uuid...
20:03:05.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.556274 11642 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } has no permanent_uuid. Determining permanent_uuid...
20:03:05.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.559288 11589 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.11.73.61:40409: connect: Connection refused (error 111)
20:03:05.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.564258 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.61:40409: Network error: Client connection negotiation failed: client connection to 127.11.73.61:40409: connect: Connection refused (error 111)
20:03:05.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.613965 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } attempt: 1
20:03:05.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.619807 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.61:40409: Network error: Client connection negotiation failed: client connection to 127.11.73.61:40409: connect: Connection refused (error 111)
20:03:05.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.688407 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } attempt: 2
20:03:05.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.694267 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.61:40409: Network error: Client connection negotiation failed: client connection to 127.11.73.61:40409: connect: Connection refused (error 111)
20:03:05.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.785833 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } attempt: 3
20:03:05.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.791983 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.61:40409: Network error: Client connection negotiation failed: client connection to 127.11.73.61:40409: connect: Connection refused (error 111)
20:03:05.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.888123 11644 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:05.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.888914 11644 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:05.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.889940 11644 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:05.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.924996 11644 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
20:03:05.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.925333 11644 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:05.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.925637 11644 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
20:03:05.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.925987 11644 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
20:03:05.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.926359 11644 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
20:03:05.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.926630 11644 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:35157/jwks.json
20:03:05.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.935509 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } attempt: 4
20:03:05.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.940704 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.61:40409: Network error: Client connection negotiation failed: client connection to 127.11.73.61:40409: connect: Connection refused (error 111)
20:03:05.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.974436 11644 master_runner.cc:387] Master server non-default flags:
20:03:05.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/logs
20:03:05.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:05.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:05.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:05.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:05.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:05.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:05.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/data
20:03:05.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/wal
20:03:05.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:03:05.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:05.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:05.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:05.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:03:05.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.61:40409
20:03:05.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:03:05.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:05.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:03:05.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35157/jwks.json
20:03:05.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:05.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:05.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/data/info.pb
20:03:05.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.61
20:03:05.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:05.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:05.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:05.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:05.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:05.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:05.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:05.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
20:03:05.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:05.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 12dab910780628d7c8d59e0ab03bf2fa661d310d
20:03:05.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:03:05.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 19:45:48 UTC on e7f111948823
20:03:05.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13295
20:03:05.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:03:05.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.975912 11644 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:05.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:05.977672 11644 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:05.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.991650 11654 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
20:03:06.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:06.240221 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } attempt: 5
20:03:06.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:06.250943 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.61:40409: Network error: Client connection negotiation failed: client connection to 127.11.73.61:40409: connect: Connection refused (error 111)
20:03:06.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:06.798643 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } attempt: 6
20:03:06.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:06.825987 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.61:40409: Network error: Client connection negotiation failed: client connection to 127.11.73.61:40409: connect: Connection refused (error 111)
20:03:07.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.997148 11657 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
20:03:07.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:05.995081 11655 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
20:03:07.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:07.260587 11656 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1260 milliseconds
20:03:07.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.260728 11644 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
20:03:07.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.262449 11644 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:07.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.265740 11644 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:07.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.267158 11644 hybrid_clock.cc:648] HybridClock initialized: now 1786478587267108 us; error 92 us; skew 500 ppm
20:03:07.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.268393 11644 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:03:07.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.276415 11644 webserver.cc:533] Webserver started at http://127.11.73.61:35457/ using document root <none> and password file <none>
20:03:07.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.277525 11644 fs_manager.cc:362] Metadata directory not provided
20:03:07.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.277740 11644 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:07.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.278251 11644 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:07.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.283125 11644 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/data/instance:
20:03:07.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ebfb61ade75849e0955d60d1017d0441"
20:03:07.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:07 on dist-test-slave-zpfg"
20:03:07.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.284767 11644 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/wal/instance:
20:03:07.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ebfb61ade75849e0955d60d1017d0441"
20:03:07.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:07 on dist-test-slave-zpfg"
20:03:07.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.293442 11644 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.010s	sys 0.000s
20:03:07.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.300599 11666 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:07.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.302093 11644 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.005s	sys 0.000s
20:03:07.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.302569 11644 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/data,/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/wal
20:03:07.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ebfb61ade75849e0955d60d1017d0441"
20:03:07.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:07 on dist-test-slave-zpfg"
20:03:07.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.303078 11644 fs_report.cc:389] FS layout report
20:03:07.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:07.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/wal
20:03:07.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/wal
20:03:07.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/data/data
20:03:07.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:07.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:07.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:07.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:07.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:07.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:07.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:07.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:07.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:07.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:07.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:07.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.363225 11644 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:07.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.365097 11644 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
20:03:07.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.365695 11644 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:07.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.471694 11644 rpc_server.cc:307] RPC server started. Bound to: 127.11.73.61:40409
20:03:07.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.472172 11720 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.11.73.61:40409 every 8 connection(s)
20:03:07.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.477337 11644 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/data/info.pb
20:03:07.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.479040 11556 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu as pid 11644
20:03:07.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.479532 11556 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-1/wal/instance
20:03:07.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.482867 11556 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:07.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:07.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/wal
20:03:07.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/data
20:03:07.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:07.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:07.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:07.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:07.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:07.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:07.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/logs
20:03:07.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/data/info.pb
20:03:07.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:07.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:07.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:07.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:07.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:07.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:07.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:07.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:07.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
20:03:07.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:07.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:03:07.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:03:07.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.60:46687
20:03:07.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.60
20:03:07.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:07.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:07.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:07.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:07.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:07.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:03:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:03:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35157/jwks.json with env {}
20:03:07.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.504973 11721 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:07.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.528683 11721 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } has no permanent_uuid. Determining permanent_uuid...
20:03:07.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.580492 11721 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } has no permanent_uuid. Determining permanent_uuid...
20:03:07.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.611706 11721 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } has no permanent_uuid. Determining permanent_uuid...
20:03:07.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:07.617501 11667 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:07.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:07.631560 11721 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:07.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.681143 11721 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 1
20:03:07.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:07.690727 11721 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:07.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.759415 11721 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 2
20:03:07.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:07.767851 11721 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:07.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.859323 11721 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 3
20:03:07.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:07.868449 11721 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:07.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.886656 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } attempt: 7
20:03:07.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.916652 11642 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } has no permanent_uuid. Determining permanent_uuid...
20:03:07.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:07.932971 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:07.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:07.991837 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 1
20:03:08.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:07.999678 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:08.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:08.012197 11721 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 4
20:03:08.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.021006 11721 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:08.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:08.081497 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 2
20:03:08.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.090252 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:08.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:08.176018 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 3
20:03:08.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.184369 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:08.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.195149 11723 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:08.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.195873 11723 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:08.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.196382 11723 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:08.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.231267 11723 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
20:03:08.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.231573 11723 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:08.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.231769 11723 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
20:03:08.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.231958 11723 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
20:03:08.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.232157 11723 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
20:03:08.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.232298 11723 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:35157/jwks.json
20:03:08.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:08.273303 11723 master_runner.cc:387] Master server non-default flags:
20:03:08.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/logs
20:03:08.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:08.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/data
20:03:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/wal
20:03:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:03:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:03:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.60:46687
20:03:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:03:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:03:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35157/jwks.json
20:03:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/data/info.pb
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.60
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
20:03:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 12dab910780628d7c8d59e0ab03bf2fa661d310d
20:03:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:03:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 19:45:48 UTC on e7f111948823
20:03:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13295
20:03:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:03:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:08.275286 11723 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:08.277906 11723 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:08.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.303349 11736 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
20:03:08.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:08.320703 11721 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 5
20:03:08.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:08.324973 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 4
20:03:08.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.335810 11721 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:08.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.337950 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:08.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:08.621618 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 5
20:03:08.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.647743 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:08.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:08.883509 11721 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 6
20:03:08.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.918620 11721 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:09.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:09.200583 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 6
20:03:09.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:09.248014 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:09.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:09.979429 11721 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 7
20:03:10.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:10.004959 11721 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:10.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:09.708520 11735 debug-util.cc:398] Leaking SignalData structure 0x7b080002ee00 after lost signal to thread 11723
20:03:10.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:08.309928 11737 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
20:03:10.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:10.016557 11723 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.706s	user 0.557s	sys 1.102s
20:03:10.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:10.017450 11723 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.708s	user 0.557s	sys 1.103s
20:03:10.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:10.021103 11740 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
20:03:10.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:10.021727 11738 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1708 milliseconds
20:03:10.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.021878 11723 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
20:03:10.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.023550 11723 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:10.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.027607 11723 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:10.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.029089 11723 hybrid_clock.cc:648] HybridClock initialized: now 1786478590029050 us; error 43 us; skew 500 ppm
20:03:10.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.030401 11723 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:03:10.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.044582 11723 webserver.cc:533] Webserver started at http://127.11.73.60:33115/ using document root <none> and password file <none>
20:03:10.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.046247 11723 fs_manager.cc:362] Metadata directory not provided
20:03:10.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.046571 11723 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:10.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.047256 11723 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:10.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.052755 11723 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/data/instance:
20:03:10.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "df610075145f4ce0bc597400d4296e3a"
20:03:10.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:10 on dist-test-slave-zpfg"
20:03:10.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.054244 11723 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/wal/instance:
20:03:10.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "df610075145f4ce0bc597400d4296e3a"
20:03:10.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:10 on dist-test-slave-zpfg"
20:03:10.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.066430 11723 fs_manager.cc:696] Time spent creating directory manager: real 0.011s	user 0.001s	sys 0.009s
20:03:10.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.079609 11755 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:10.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.082619 11723 fs_manager.cc:730] Time spent opening block manager: real 0.011s	user 0.005s	sys 0.004s
20:03:10.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.083091 11723 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/data,/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/wal
20:03:10.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "df610075145f4ce0bc597400d4296e3a"
20:03:10.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:10 on dist-test-slave-zpfg"
20:03:10.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.083695 11723 fs_report.cc:389] FS layout report
20:03:10.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:10.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/wal
20:03:10.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/wal
20:03:10.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/data/data
20:03:10.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:10.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:10.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:10.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:10.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:10.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:10.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:10.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:10.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:10.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:10.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:10.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.167845 11723 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:10.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.170858 11723 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
20:03:10.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.171826 11723 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:10.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.281873 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 7
20:03:10.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:10.303085 11642 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.11.73.60:46687: Network error: Client connection negotiation failed: client connection to 127.11.73.60:46687: connect: Connection refused (error 111)
20:03:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.470557 11723 rpc_server.cc:307] RPC server started. Bound to: 127.11.73.60:46687
20:03:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.470780 11809 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.11.73.60:46687 every 8 connection(s)
20:03:10.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.475275 11723 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/data/info.pb
20:03:10.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.484865 11556 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu as pid 11723
20:03:10.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.485735 11556 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/master-2/wal/instance
20:03:10.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.493903 11811 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:10.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.539669 11811 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } has no permanent_uuid. Determining permanent_uuid...
20:03:10.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.590148 11811 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } has no permanent_uuid. Determining permanent_uuid...
20:03:10.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.608777 11811 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } has no permanent_uuid. Determining permanent_uuid...
20:03:10.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.641855 11811 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a: Bootstrap starting.
20:03:10.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.660928 11811 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a: Neither blocks nor log segments found. Creating new log.
20:03:10.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.665735 11811 log.cc:826] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a: Log is configured to *not* fsync() on all Append() calls
20:03:10.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.676904 11811 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a: No bootstrap required, opened a new log
20:03:10.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.716746 11811 raft_consensus.cc:359] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } }
20:03:10.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.717746 11811 raft_consensus.cc:385] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:10.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.717995 11811 raft_consensus.cc:740] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: df610075145f4ce0bc597400d4296e3a, State: Initialized, Role: FOLLOWER
20:03:10.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.719645 11811 consensus_queue.cc:260] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [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: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } }
20:03:10.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.726595 11820 sys_catalog.cc:455] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [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: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } } }
20:03:10.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.727451 11820 sys_catalog.cc:458] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [sys.catalog]: This master's current role is: FOLLOWER
20:03:10.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.730973 11811 sys_catalog.cc:565] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [sys.catalog]: configured and running, proceeding with master startup.
20:03:10.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:10.822887 11832 catalog_manager.cc:1594] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
20:03:10.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:10.824409 11832 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
20:03:10.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.809679 11723 master_runner.cc:187] Error getting master registration for 127.11.73.62:41783: OK, instance_id { permanent_uuid: "323732fdc41141d8ad38ea835d703162" instance_seqno: 1786478585474499 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
20:03:10.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.850953 11723 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
20:03:10.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:10.938710 11761 tablet.cc:2406] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:03:10.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.951640 11820 raft_consensus.cc:493] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
20:03:10.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.952472 11820 raft_consensus.cc:515] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } }
20:03:10.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:10.957396 11820 leader_election.cc:290] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 323732fdc41141d8ad38ea835d703162 (127.11.73.62:41783), ebfb61ade75849e0955d60d1017d0441 (127.11.73.61:40409)
20:03:11.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:11.832926 11832 catalog_manager.cc:1594] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
20:03:11.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:11.833518 11832 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
20:03:12.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.095711 11721 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 8
20:03:12.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.141503 11721 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441: Bootstrap starting.
20:03:12.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.160137 11721 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441: Neither blocks nor log segments found. Creating new log.
20:03:12.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.166795 11721 log.cc:826] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441: Log is configured to *not* fsync() on all Append() calls
20:03:12.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.179654 11721 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441: No bootstrap required, opened a new log
20:03:12.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.232120 11721 raft_consensus.cc:359] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } }
20:03:12.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.233561 11721 raft_consensus.cc:385] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:12.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.234100 11721 raft_consensus.cc:740] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ebfb61ade75849e0955d60d1017d0441, State: Initialized, Role: FOLLOWER
20:03:12.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.235931 11721 consensus_queue.cc:260] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [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: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } }
20:03:12.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.243762 11839 sys_catalog.cc:455] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [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: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } } }
20:03:12.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.245632 11839 sys_catalog.cc:458] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [sys.catalog]: This master's current role is: FOLLOWER
20:03:12.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.247229 11721 sys_catalog.cc:565] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [sys.catalog]: configured and running, proceeding with master startup.
20:03:12.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.251022 11695 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "df610075145f4ce0bc597400d4296e3a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ebfb61ade75849e0955d60d1017d0441" is_pre_election: true
20:03:12.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.252493 11695 raft_consensus.cc:2468] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate df610075145f4ce0bc597400d4296e3a in term 0.
20:03:12.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.253593 11695 rpcz_store.cc:275] Call kudu.consensus.ConsensusService.RequestConsensusVote from 127.0.0.1:48658 (request call id 1) took 1294 ms. Trace:
20:03:12.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.254216 11695 rpcz_store.cc:276] 0811 20:03:10.959342 (+     0us) service_pool.cc:167] Inserting onto call queue
20:03:12.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 20:03:10.959576 (+   234us) service_pool.cc:224] Handling call
20:03:12.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 20:03:12.253492 (+1293916us) inbound_call.cc:177] Queueing success response
20:03:12.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {}
20:03:12.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.258776 11757 leader_election.cc:304] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [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: df610075145f4ce0bc597400d4296e3a, ebfb61ade75849e0955d60d1017d0441; no voters: 
20:03:12.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.271581 11841 raft_consensus.cc:2804] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [term 0 FOLLOWER]: Leader pre-election won for term 1
20:03:12.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.273164 11841 raft_consensus.cc:493] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
20:03:12.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.274127 11841 raft_consensus.cc:3060] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [term 0 FOLLOWER]: Advancing to term 1
20:03:12.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.291723 11841 raft_consensus.cc:515] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } }
20:03:12.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.299474 11841 leader_election.cc:290] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [CANDIDATE]: Term 1 election: Requested vote from peers 323732fdc41141d8ad38ea835d703162 (127.11.73.62:41783), ebfb61ade75849e0955d60d1017d0441 (127.11.73.61:40409)
20:03:12.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.300729 11695 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "df610075145f4ce0bc597400d4296e3a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ebfb61ade75849e0955d60d1017d0441"
20:03:12.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.301822 11695 raft_consensus.cc:3060] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [term 0 FOLLOWER]: Advancing to term 1
20:03:12.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.319000 11695 raft_consensus.cc:2468] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate df610075145f4ce0bc597400d4296e3a in term 1.
20:03:12.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.321166 11757 leader_election.cc:304] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [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: df610075145f4ce0bc597400d4296e3a, ebfb61ade75849e0955d60d1017d0441; no voters: 
20:03:12.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.324712 11841 raft_consensus.cc:2804] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [term 1 FOLLOWER]: Leader election won for term 1
20:03:12.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.335218 11841 raft_consensus.cc:697] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [term 1 LEADER]: Becoming Leader. State: Replica: df610075145f4ce0bc597400d4296e3a, State: Running, Role: LEADER
20:03:12.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.337476 11841 consensus_queue.cc:237] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [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: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } }
20:03:12.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.364663 11642 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } attempt: 8
20:03:12.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.370888 11847 sys_catalog.cc:455] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [sys.catalog]: SysCatalogTable state changed. Reason: New leader df610075145f4ce0bc597400d4296e3a. Latest consensus state: current_term: 1 leader_uuid: "df610075145f4ce0bc597400d4296e3a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } } }
20:03:12.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.377207 11847 sys_catalog.cc:458] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [sys.catalog]: This master's current role is: LEADER
20:03:12.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:12.381613 11672 tablet.cc:2406] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:03:12.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.408571 11854 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
20:03:12.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.425215 11854 catalog_manager.cc:1520] Initializing Kudu cluster ID...
20:03:12.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.434145 11642 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162: Bootstrap starting.
20:03:12.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:12.478922 11855 catalog_manager.cc:1594] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
20:03:12.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:12.485994 11855 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
20:03:12.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.405754 11644 master_runner.cc:187] Error getting master registration for 127.11.73.62:41783: OK, instance_id { permanent_uuid: "323732fdc41141d8ad38ea835d703162" instance_seqno: 1786478585474499 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
20:03:12.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.495919 11644 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
20:03:12.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.504251 11695 raft_consensus.cc:1275] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [term 1 FOLLOWER]: Refusing update from remote peer df610075145f4ce0bc597400d4296e3a: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
20:03:12.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.508658 11847 consensus_queue.cc:1048] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [LEADER]: Connected to new peer: Peer: permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
20:03:12.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.559684 11642 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162: Neither blocks nor log segments found. Creating new log.
20:03:12.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.566567 11642 log.cc:826] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162: Log is configured to *not* fsync() on all Append() calls
20:03:12.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.581477 11642 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162: No bootstrap required, opened a new log
20:03:12.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.676673 11839 sys_catalog.cc:455] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [sys.catalog]: SysCatalogTable state changed. Reason: New leader df610075145f4ce0bc597400d4296e3a. Latest consensus state: current_term: 1 leader_uuid: "df610075145f4ce0bc597400d4296e3a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } } }
20:03:12.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.680084 11839 sys_catalog.cc:458] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [sys.catalog]: This master's current role is: FOLLOWER
20:03:12.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.683310 11642 raft_consensus.cc:359] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } }
20:03:12.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.687238 11642 raft_consensus.cc:385] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:12.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.687952 11847 sys_catalog.cc:455] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "df610075145f4ce0bc597400d4296e3a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } } }
20:03:12.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.688248 11642 raft_consensus.cc:740] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 323732fdc41141d8ad38ea835d703162, State: Initialized, Role: FOLLOWER
20:03:12.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.689046 11847 sys_catalog.cc:458] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [sys.catalog]: This master's current role is: LEADER
20:03:12.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.692673 11642 consensus_queue.cc:260] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [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: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } }
20:03:12.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.698650 11854 catalog_manager.cc:1383] Generated new cluster ID: cc68c2f178ce4fc8bd538660268e1bc9
20:03:12.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.699146 11854 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
20:03:12.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.721167 11839 sys_catalog.cc:455] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "df610075145f4ce0bc597400d4296e3a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } } }
20:03:12.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.722368 11839 sys_catalog.cc:458] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441 [sys.catalog]: This master's current role is: FOLLOWER
20:03:12.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.720191 11863 sys_catalog.cc:455] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [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: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } } }
20:03:12.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.733392 11642 sys_catalog.cc:565] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [sys.catalog]: configured and running, proceeding with master startup.
20:03:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.734467 11615 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "df610075145f4ce0bc597400d4296e3a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "323732fdc41141d8ad38ea835d703162" is_pre_election: true
20:03:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.736304 11615 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate df610075145f4ce0bc597400d4296e3a in term 0.
20:03:12.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.739313 11614 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "df610075145f4ce0bc597400d4296e3a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "323732fdc41141d8ad38ea835d703162"
20:03:12.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.741027 11863 sys_catalog.cc:458] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [sys.catalog]: This master's current role is: FOLLOWER
20:03:12.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.742374 11613 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [term 0 FOLLOWER]: Advancing to term 1
20:03:12.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:12.737232 11615 rpcz_store.cc:267] Call kudu.consensus.ConsensusService.RequestConsensusVote from 127.0.0.1:55962 (request call id 2) took 1779 ms (client timeout 2119 ms). Trace:
20:03:12.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:12.745792 11615 rpcz_store.cc:269] 0811 20:03:10.958523 (+     0us) service_pool.cc:167] Inserting onto call queue
20:03:12.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 20:03:10.958874 (+   351us) service_pool.cc:224] Handling call
20:03:12.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0811 20:03:12.737099 (+1778225us) inbound_call.cc:177] Queueing success response
20:03:12.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {}
20:03:12.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.764521 11613 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [term 1 FOLLOWER]: Refusing update from remote peer df610075145f4ce0bc597400d4296e3a: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
20:03:12.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.768468 11841 consensus_queue.cc:1048] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [LEADER]: Connected to new peer: Peer: permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
20:03:12.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.836021 11854 catalog_manager.cc:1406] Generated new certificate authority record
20:03:12.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.853772 11854 catalog_manager.cc:1540] Loading token signing keys...
20:03:12.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.929458 11863 sys_catalog.cc:455] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [sys.catalog]: SysCatalogTable state changed. Reason: New leader df610075145f4ce0bc597400d4296e3a. Latest consensus state: current_term: 1 leader_uuid: "df610075145f4ce0bc597400d4296e3a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } } }
20:03:12.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.931620 11863 sys_catalog.cc:458] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [sys.catalog]: This master's current role is: FOLLOWER
20:03:12.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.931286 11874 sys_catalog.cc:455] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "df610075145f4ce0bc597400d4296e3a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } } }
20:03:12.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.932595 11874 sys_catalog.cc:458] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162 [sys.catalog]: This master's current role is: FOLLOWER
20:03:12.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.950224 11841 sys_catalog.cc:455] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "df610075145f4ce0bc597400d4296e3a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "323732fdc41141d8ad38ea835d703162" member_type: VOTER last_known_addr { host: "127.11.73.62" port: 41783 } } peers { permanent_uuid: "ebfb61ade75849e0955d60d1017d0441" member_type: VOTER last_known_addr { host: "127.11.73.61" port: 40409 } } peers { permanent_uuid: "df610075145f4ce0bc597400d4296e3a" member_type: VOTER last_known_addr { host: "127.11.73.60" port: 46687 } } }
20:03:12.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.963702 11841 sys_catalog.cc:458] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a [sys.catalog]: This master's current role is: LEADER
20:03:12.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.982046 11854 catalog_manager.cc:6092] T 00000000000000000000000000000000 P df610075145f4ce0bc597400d4296e3a: Generated new TSK 0
20:03:12.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:12.984189 11854 catalog_manager.cc:1550] Initializing in-progress tserver states...
20:03:13.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:13.009366 11556 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:13.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:13.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/wal
20:03:13.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/data
20:03:13.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:13.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:13.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:13.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:13.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:13.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:13.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/logs
20:03:13.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/data/info.pb
20:03:13.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:13.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:13.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:13.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:13.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:13.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.1:0
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.73.1
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.1
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:13.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
20:03:13.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:13.090101 11879 catalog_manager.cc:1295] Loaded cluster ID: cc68c2f178ce4fc8bd538660268e1bc9
20:03:13.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:13.090656 11879 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162: loading cluster ID for follower catalog manager: success
20:03:13.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:13.121943 11879 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162: acquiring CA information for follower catalog manager: success
20:03:13.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:13.150952 11879 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 323732fdc41141d8ad38ea835d703162: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
20:03:13.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:13.497702 11855 catalog_manager.cc:1295] Loaded cluster ID: cc68c2f178ce4fc8bd538660268e1bc9
20:03:13.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:13.498139 11855 catalog_manager.cc:1588] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441: loading cluster ID for follower catalog manager: success
20:03:13.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:13.530304 11855 catalog_manager.cc:1610] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441: acquiring CA information for follower catalog manager: success
20:03:13.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:13.548254 11855 catalog_manager.cc:1638] T 00000000000000000000000000000000 P ebfb61ade75849e0955d60d1017d0441: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
20:03:13.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:13.988826 11882 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:13.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:13.989609 11882 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:13.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:13.990525 11882 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:14.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:14.059906 11882 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:14.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:14.062175 11882 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.11.73.1
20:03:14.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:14.141899 11882 tablet_server_runner.cc:78] Tablet server non-default flags:
20:03:14.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/logs
20:03:14.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:14.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:14.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:14.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:14.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:14.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:14.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/data
20:03:14.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/wal
20:03:14.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:14.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:14.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.1:0
20:03:14.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:14.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:14.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:14.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/data/info.pb
20:03:14.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.1
20:03:14.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:14.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:14.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:14.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:14.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:14.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:14.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:14.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.73.1
20:03:14.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:14.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:03:14.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:14.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 12dab910780628d7c8d59e0ab03bf2fa661d310d
20:03:14.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:03:14.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 19:45:48 UTC on e7f111948823
20:03:14.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13295
20:03:14.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:03:14.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:14.149345 11882 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:14.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:14.152660 11882 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:14.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:14.194140 11894 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
20:03:16.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:15.586557 11892 debug-util.cc:398] Leaking SignalData structure 0x7b080002ede0 after lost signal to thread 11882
20:03:16.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:16.598806 11892 kernel_stack_watchdog.cc:198] Thread 11882 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 390ms:
20:03:16.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
20:03:16.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
20:03:16.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
20:03:16.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
20:03:16.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:14.195063 11893 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
20:03:16.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:16.601598 11882 thread.cc:641] GCE (cloud detector) Time spent creating pthread: real 2.411s	user 0.517s	sys 0.911s
20:03:16.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:16.602290 11882 thread.cc:608] GCE (cloud detector) Time spent starting thread: real 2.412s	user 0.517s	sys 0.912s
20:03:16.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.608820 11882 server_base.cc:1061] running on GCE node
20:03:16.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:16.610114 11899 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
20:03:16.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.612005 11882 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:16.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.615401 11882 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:16.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.619144 11882 hybrid_clock.cc:648] HybridClock initialized: now 1786478596619053 us; error 62 us; skew 500 ppm
20:03:16.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.620590 11882 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:03:16.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.631393 11882 webserver.cc:533] Webserver started at http://127.11.73.1:44609/ using document root <none> and password file <none>
20:03:16.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.632967 11882 fs_manager.cc:362] Metadata directory not provided
20:03:16.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.633278 11882 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:16.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.634066 11882 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:16.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.641984 11882 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/data/instance:
20:03:16.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9cf8ea7cda234640bd5597e1f35e9d1c"
20:03:16.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:16 on dist-test-slave-zpfg"
20:03:16.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.643744 11882 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/wal/instance:
20:03:16.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9cf8ea7cda234640bd5597e1f35e9d1c"
20:03:16.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:16 on dist-test-slave-zpfg"
20:03:16.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.659399 11882 fs_manager.cc:696] Time spent creating directory manager: real 0.015s	user 0.005s	sys 0.009s
20:03:16.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.676487 11904 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:16.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.678301 11882 fs_manager.cc:730] Time spent opening block manager: real 0.011s	user 0.001s	sys 0.007s
20:03:16.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.679219 11882 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/data,/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/wal
20:03:16.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9cf8ea7cda234640bd5597e1f35e9d1c"
20:03:16.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:16 on dist-test-slave-zpfg"
20:03:16.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.679935 11882 fs_report.cc:389] FS layout report
20:03:16.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:16.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/wal
20:03:16.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/wal
20:03:16.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/data/data
20:03:16.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:16.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:16.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:16.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:16.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:16.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:16.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:16.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:16.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:16.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:16.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:16.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.790642 11882 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:16.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.794596 11882 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
20:03:16.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.795439 11882 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:16.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.809177 11882 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:03:16.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.822593 11882 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:03:16.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.823132 11882 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.001s	user 0.000s	sys 0.000s
20:03:16.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.823720 11882 ts_tablet_manager.cc:616] Registered 0 tablets
20:03:16.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:16.824045 11882 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
20:03:17.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.705474 11882 rpc_server.cc:307] RPC server started. Bound to: 127.11.73.1:44167
20:03:17.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.706562 12023 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.11.73.1:44167 every 8 connection(s)
20:03:17.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.711422 11882 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/data/info.pb
20:03:17.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.718061 11556 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu as pid 11882
20:03:17.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.719370 11556 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-0/wal/instance
20:03:17.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.738997 11556 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:17.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:17.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/wal
20:03:17.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/data
20:03:17.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:17.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:17.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:17.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:17.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/logs
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/data/info.pb
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:17.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:03:17.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:17.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.2:0
20:03:17.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.73.2
20:03:17.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.2
20:03:17.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:17.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:17.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:17.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:17.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:17.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
20:03:17.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.869401 12024 heartbeater.cc:344] Connected to a master server at 127.11.73.60:46687
20:03:17.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.872750 12024 heartbeater.cc:461] Registering TS with master...
20:03:17.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.876049 12024 heartbeater.cc:507] Master 127.11.73.60:46687 requested a full tablet report, sending...
20:03:17.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.882587 11773 ts_manager.cc:194] Registered new tserver with Master: 9cf8ea7cda234640bd5597e1f35e9d1c (127.11.73.1:44167)
20:03:17.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.887095 12029 heartbeater.cc:344] Connected to a master server at 127.11.73.62:41783
20:03:17.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.887774 12029 heartbeater.cc:461] Registering TS with master...
20:03:17.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.888265 11773 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.11.73.1:50425
20:03:17.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.890197 12029 heartbeater.cc:507] Master 127.11.73.62:41783 requested a full tablet report, sending...
20:03:17.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.893833 12028 heartbeater.cc:344] Connected to a master server at 127.11.73.61:40409
20:03:17.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.894529 12028 heartbeater.cc:461] Registering TS with master...
20:03:17.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.896041 12028 heartbeater.cc:507] Master 127.11.73.61:40409 requested a full tablet report, sending...
20:03:17.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.900573 11605 ts_manager.cc:194] Registered new tserver with Master: 9cf8ea7cda234640bd5597e1f35e9d1c (127.11.73.1:44167)
20:03:17.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:17.900774 11684 ts_manager.cc:194] Registered new tserver with Master: 9cf8ea7cda234640bd5597e1f35e9d1c (127.11.73.1:44167)
20:03:18.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:18.288961 12026 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:18.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:18.289625 12026 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:18.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:18.290078 12026 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:18.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:18.326982 12026 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:18.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:18.327963 12026 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.11.73.2
20:03:18.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:18.368839 12026 tablet_server_runner.cc:78] Tablet server non-default flags:
20:03:18.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/logs
20:03:18.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:18.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:18.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/data
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/wal
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.2:0
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/data/info.pb
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.2
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:18.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.73.2
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 12dab910780628d7c8d59e0ab03bf2fa661d310d
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 19:45:48 UTC on e7f111948823
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13295
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:03:18.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:18.370517 12026 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:18.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:18.372375 12026 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:18.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:18.388370 12042 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
20:03:18.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:18.897076 12024 heartbeater.cc:499] Master 127.11.73.60:46687 was elected leader, sending a full tablet report...
20:03:19.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:18.389326 12043 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
20:03:19.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:19.761627 12045 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
20:03:19.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:19.764550 12044 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1369 milliseconds
20:03:19.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.764639 12026 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
20:03:19.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.766098 12026 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:19.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.768616 12026 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:19.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.770176 12026 hybrid_clock.cc:648] HybridClock initialized: now 1786478599770128 us; error 51 us; skew 500 ppm
20:03:19.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.771385 12026 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:03:19.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.778970 12026 webserver.cc:533] Webserver started at http://127.11.73.2:37783/ using document root <none> and password file <none>
20:03:19.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.780140 12026 fs_manager.cc:362] Metadata directory not provided
20:03:19.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.780352 12026 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:19.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.780798 12026 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:19.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.785475 12026 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/data/instance:
20:03:19.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5f319514b7db4bf7ba03831620f4b1e0"
20:03:19.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:19 on dist-test-slave-zpfg"
20:03:19.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.786777 12026 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/wal/instance:
20:03:19.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5f319514b7db4bf7ba03831620f4b1e0"
20:03:19.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:19 on dist-test-slave-zpfg"
20:03:19.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.795408 12026 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.007s	sys 0.001s
20:03:19.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.802397 12054 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:19.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.803907 12026 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.002s	sys 0.001s
20:03:19.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.804242 12026 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/data,/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/wal
20:03:19.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5f319514b7db4bf7ba03831620f4b1e0"
20:03:19.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:19 on dist-test-slave-zpfg"
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.804567 12026 fs_report.cc:389] FS layout report
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/wal
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/wal
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/data/data
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:19.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.891845 12026 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:19.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.893527 12026 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
20:03:19.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.894029 12026 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:19.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.899720 12026 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:03:19.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.906562 12026 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:03:19.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.906841 12026 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
20:03:19.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.907054 12026 ts_tablet_manager.cc:616] Registered 0 tablets
20:03:19.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:19.907186 12026 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
20:03:20.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.408250 12026 rpc_server.cc:307] RPC server started. Bound to: 127.11.73.2:36485
20:03:20.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.408742 12171 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.11.73.2:36485 every 8 connection(s)
20:03:20.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.411250 12026 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/data/info.pb
20:03:20.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.418771 11556 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu as pid 12026
20:03:20.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.419505 11556 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-1/wal/instance
20:03:20.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.482928 11556 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:20.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu
20:03:20.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/wal
20:03:20.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/data
20:03:20.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:20.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:20.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:20.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:20.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:20.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:20.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/logs
20:03:20.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/data/info.pb
20:03:20.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:20.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:20.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:20.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:20.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:20.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:20.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:20.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:20.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:03:20.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:20.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.3:0
20:03:20.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.73.3
20:03:20.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.3
20:03:20.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:20.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:20.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:20.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:20.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:20.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
20:03:20.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.562163 12173 heartbeater.cc:344] Connected to a master server at 127.11.73.61:40409
20:03:20.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.563071 12173 heartbeater.cc:461] Registering TS with master...
20:03:20.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.570436 12173 heartbeater.cc:507] Master 127.11.73.61:40409 requested a full tablet report, sending...
20:03:20.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.574569 11684 ts_manager.cc:194] Registered new tserver with Master: 5f319514b7db4bf7ba03831620f4b1e0 (127.11.73.2:36485)
20:03:20.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.585824 12172 heartbeater.cc:344] Connected to a master server at 127.11.73.60:46687
20:03:20.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.586509 12172 heartbeater.cc:461] Registering TS with master...
20:03:20.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.588629 12176 heartbeater.cc:344] Connected to a master server at 127.11.73.62:41783
20:03:20.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.588856 12172 heartbeater.cc:507] Master 127.11.73.60:46687 requested a full tablet report, sending...
20:03:20.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.589140 12176 heartbeater.cc:461] Registering TS with master...
20:03:20.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.591573 12176 heartbeater.cc:507] Master 127.11.73.62:41783 requested a full tablet report, sending...
20:03:20.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.593755 11773 ts_manager.cc:194] Registered new tserver with Master: 5f319514b7db4bf7ba03831620f4b1e0 (127.11.73.2:36485)
20:03:20.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.596279 11605 ts_manager.cc:194] Registered new tserver with Master: 5f319514b7db4bf7ba03831620f4b1e0 (127.11.73.2:36485)
20:03:20.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:20.597855 11773 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.11.73.2:59795
20:03:21.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:21.205001 12182 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:21.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:21.205732 12182 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:21.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:21.206418 12182 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:21.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:21.242616 12182 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:21.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:21.243675 12182 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.11.73.3
20:03:21.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:21.284849 12182 tablet_server_runner.cc:78] Tablet server non-default flags:
20:03:21.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/logs
20:03:21.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:21.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:21.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:21.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.73.20:36209
20:03:21.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/data
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/wal
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.73.3:0
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/data/info.pb
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.73.3
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.73.62:41783,127.11.73.61:40409,127.11.73.60:46687
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.73.3
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 12dab910780628d7c8d59e0ab03bf2fa661d310d
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 19:45:48 UTC on e7f111948823
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13295
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:03:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:21.286862 12182 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:21.288842 12182 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:21.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:21.307611 12189 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
20:03:21.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:21.609368 12172 heartbeater.cc:499] Master 127.11.73.60:46687 was elected leader, sending a full tablet report...
20:03:23.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:21.312083 12190 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
20:03:23.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:22.718637 12188 debug-util.cc:398] Leaking SignalData structure 0x7b080002ede0 after lost signal to thread 12182
20:03:23.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:23.010113 12182 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.699s	user 0.638s	sys 1.010s
20:03:23.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:23.010965 12182 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.701s	user 0.639s	sys 1.010s
20:03:23.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:23.010717 12191 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
20:03:23.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.015370 12182 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
20:03:23.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:23.015976 12192 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
20:03:23.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.018023 12182 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.020620 12182 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:23.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.024245 12182 hybrid_clock.cc:648] HybridClock initialized: now 1786478603024151 us; error 67 us; skew 500 ppm
20:03:23.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.025221 12182 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:03:23.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.041769 12182 webserver.cc:533] Webserver started at http://127.11.73.3:33045/ using document root <none> and password file <none>
20:03:23.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.042976 12182 fs_manager.cc:362] Metadata directory not provided
20:03:23.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.043226 12182 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:23.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.043768 12182 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:23.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.049427 12182 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/data/instance:
20:03:23.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a862250c606c43a09fcd6eb34736359d"
20:03:23.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:23 on dist-test-slave-zpfg"
20:03:23.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.050824 12182 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/wal/instance:
20:03:23.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a862250c606c43a09fcd6eb34736359d"
20:03:23.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:23 on dist-test-slave-zpfg"
20:03:23.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.066006 12182 fs_manager.cc:696] Time spent creating directory manager: real 0.015s	user 0.001s	sys 0.010s
20:03:23.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.078502 12199 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:23.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.080255 12182 fs_manager.cc:730] Time spent opening block manager: real 0.009s	user 0.003s	sys 0.004s
20:03:23.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.080590 12182 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/data,/tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/wal
20:03:23.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a862250c606c43a09fcd6eb34736359d"
20:03:23.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 20:03:23 on dist-test-slave-zpfg"
20:03:23.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.081027 12182 fs_report.cc:389] FS layout report
20:03:23.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:23.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/wal
20:03:23.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/wal
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/data/data
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:23.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.168473 12182 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:23.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.172202 12182 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
20:03:23.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.172935 12182 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:23.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.181178 12182 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:03:23.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.190534 12182 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:03:23.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.190853 12182 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
20:03:23.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.191089 12182 ts_tablet_manager.cc:616] Registered 0 tablets
20:03:23.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.191237 12182 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
20:03:23.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.873173 12182 rpc_server.cc:307] RPC server started. Bound to: 127.11.73.3:39789
20:03:23.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.873438 12320 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.11.73.3:39789 every 8 connection(s)
20:03:23.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.876691 12182 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/data/info.pb
20:03:23.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.885244 11556 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu as pid 12182
20:03:23.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.887220 11556 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskOcLkUh/test-tmp/mini-kudu-cluster11728038729287152874/ts-2/wal/instance
20:03:23.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.963231 12323 heartbeater.cc:344] Connected to a master server at 127.11.73.61:40409
20:03:23.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.963902 12323 heartbeater.cc:461] Registering TS with master...
20:03:23.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.965615 12323 heartbeater.cc:507] Master 127.11.73.61:40409 requested a full tablet report, sending...
20:03:23.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.969496 11683 ts_manager.cc:194] Registered new tserver with Master: a862250c606c43a09fcd6eb34736359d (127.11.73.3:39789)
20:03:23.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.971017 12322 heartbeater.cc:344] Connected to a master server at 127.11.73.60:46687
20:03:23.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.971367 12322 heartbeater.cc:461] Registering TS with master...
20:03:23.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.972927 12322 heartbeater.cc:507] Master 127.11.73.60:46687 requested a full tablet report, sending...
20:03:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.976647 11773 ts_manager.cc:194] Registered new tserver with Master: a862250c606c43a09fcd6eb34736359d (127.11.73.3:39789)
20:03:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.978614 11773 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.11.73.3:52391
20:03:23.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.984421 12326 heartbeater.cc:344] Connected to a master server at 127.11.73.62:41783
20:03:23.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.984818 12326 heartbeater.cc:461] Registering TS with master...
20:03:23.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.985585 12326 heartbeater.cc:507] Master 127.11.73.62:41783 requested a full tablet report, sending...
20:03:23.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:23.988095 11605 ts_manager.cc:194] Registered new tserver with Master: a862250c606c43a09fcd6eb34736359d (127.11.73.3:39789)
20:03:24.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:24.012737 11556 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
20:03:24.025 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
20:03:24.027 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

20:03:24.038 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.11.73.62"
      port: 41783
    }
    bound_http_address {
      host: "127.11.73.62"
      port: 39753
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.11.73.61"
      port: 40409
    }
    bound_http_address {
      host: "127.11.73.61"
      port: 35457
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.11.73.60"
      port: 46687
    }
    bound_http_address {
      host: "127.11.73.60"
      port: 33115
    }
  }
}

20:03:24.041 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

20:03:24.044 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.11.73.1"
      port: 44167
    }
    bound_http_address {
      host: "127.11.73.1"
      port: 44609
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.11.73.2"
      port: 36485
    }
    bound_http_address {
      host: "127.11.73.2"
      port: 37783
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.11.73.3"
      port: 39789
    }
    bound_http_address {
      host: "127.11.73.3"
      port: 33045
    }
  }
}

20:03:24.045 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
20:03:24.234 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttemptAndReport(RetryRule.java:184)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:244)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
20:03:24.293 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
20:03:24.446 [DEBUG - main] (Connection.java:748) [peer master-127.11.73.62:41783(127.11.73.62:41783)] connecting to peer
20:03:24.521 [DEBUG - main] (Connection.java:748) [peer master-127.11.73.61:40409(127.11.73.61:40409)] connecting to peer
20:03:24.523 [DEBUG - main] (Connection.java:748) [peer master-127.11.73.60:46687(127.11.73.60:46687)] connecting to peer
20:03:24.541 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.11.73.62:41783(127.11.73.62:41783)] Successfully connected to peer
20:03:24.542 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.11.73.60:46687(127.11.73.60:46687)] Successfully connected to peer
20:03:24.552 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.11.73.61:40409(127.11.73.61:40409)] Successfully connected to peer
20:03:24.666 [DEBUG - kudu-nio-2] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.11.73.60
20:03:24.666 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.11.73.62
20:03:24.667 [DEBUG - kudu-nio-1] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.11.73.61
20:03:24.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:24.983789 12322 heartbeater.cc:499] Master 127.11.73.60:46687 was elected leader, sending a full tablet report...
20:03:24.993 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0x39a144d5, L:/127.0.0.1:46084 - R:/127.11.73.61:40409] using SASL/PLAIN
20:03:24.993 [DEBUG - kudu-nio-2] (Negotiator.java:918) Authenticated connection [id: 0x6dd0ebfa, L:/127.0.0.1:54970 - R:/127.11.73.60:46687] using SASL/PLAIN
20:03:24.993 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0x2e11ed59, L:/127.0.0.1:52558 - R:/127.11.73.62:41783] using SASL/PLAIN
20:03:25.036 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
20:03:25.037 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=632), Traces: [0ms] refreshing cache from master, [26ms] Sub RPC ConnectToMaster: sending RPC to server master-127.11.73.62:41783, [113ms] Sub RPC ConnectToMaster: sending RPC to server master-127.11.73.61:40409, [115ms] Sub RPC ConnectToMaster: sending RPC to server master-127.11.73.60:46687, [601ms] Sub RPC ConnectToMaster: received response from server master-127.11.73.61:40409: OK, [601ms] Sub RPC ConnectToMaster: received response from server master-127.11.73.62:41783: OK, [602ms] Sub RPC ConnectToMaster: received response from server master-127.11.73.60:46687: OK, deferred=null) after lookup
20:03:25.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.088728 11773 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:54970:
20:03:25.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1786478582821"
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:03:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
20:03:25.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:25.091882 11773 catalog_manager.cc:7099] 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-1786478582821 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
20:03:25.157 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:894) Opened table 46225568d661499c8888c9949c60a875
20:03:25.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.213990 12250 tablet_service.cc:1511] Processing CreateTablet for tablet 8831ed7159d14a68afaa6feffb2dd402 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786478582821 [id=46225568d661499c8888c9949c60a875]), partition=RANGE (key) PARTITION UNBOUNDED
20:03:25.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.216074 12250 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 8831ed7159d14a68afaa6feffb2dd402. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:25.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.219033 12106 tablet_service.cc:1511] Processing CreateTablet for tablet 8831ed7159d14a68afaa6feffb2dd402 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786478582821 [id=46225568d661499c8888c9949c60a875]), partition=RANGE (key) PARTITION UNBOUNDED
20:03:25.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.221679 12106 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 8831ed7159d14a68afaa6feffb2dd402. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:25.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.241902 11955 tablet_service.cc:1511] Processing CreateTablet for tablet 8831ed7159d14a68afaa6feffb2dd402 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786478582821 [id=46225568d661499c8888c9949c60a875]), partition=RANGE (key) PARTITION UNBOUNDED
20:03:25.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.250586 11955 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 8831ed7159d14a68afaa6feffb2dd402. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:25.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.283219 12358 tablet_bootstrap.cc:492] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0: Bootstrap starting.
20:03:25.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.289991 12359 tablet_bootstrap.cc:492] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d: Bootstrap starting.
20:03:25.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.306777 12358 tablet_bootstrap.cc:654] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0: Neither blocks nor log segments found. Creating new log.
20:03:25.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.314239 12359 tablet_bootstrap.cc:654] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d: Neither blocks nor log segments found. Creating new log.
20:03:25.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.314674 12358 log.cc:826] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0: Log is configured to *not* fsync() on all Append() calls
20:03:25.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.322156 12359 log.cc:826] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d: Log is configured to *not* fsync() on all Append() calls
20:03:25.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.326107 12360 tablet_bootstrap.cc:492] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c: Bootstrap starting.
20:03:25.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.340378 12358 tablet_bootstrap.cc:492] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0: No bootstrap required, opened a new log
20:03:25.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.341261 12358 ts_tablet_manager.cc:1403] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0: Time spent bootstrapping tablet: real 0.060s	user 0.012s	sys 0.041s
20:03:25.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.341346 12359 tablet_bootstrap.cc:492] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d: No bootstrap required, opened a new log
20:03:25.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.342387 12359 ts_tablet_manager.cc:1403] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d: Time spent bootstrapping tablet: real 0.054s	user 0.023s	sys 0.028s
20:03:25.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.354707 12360 tablet_bootstrap.cc:654] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c: Neither blocks nor log segments found. Creating new log.
20:03:25.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.362660 12360 log.cc:826] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c: Log is configured to *not* fsync() on all Append() calls
20:03:25.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.379781 12360 tablet_bootstrap.cc:492] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c: No bootstrap required, opened a new log
20:03:25.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.380712 12360 ts_tablet_manager.cc:1403] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c: Time spent bootstrapping tablet: real 0.057s	user 0.024s	sys 0.025s
20:03:25.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.399010 12358 raft_consensus.cc:359] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5f319514b7db4bf7ba03831620f4b1e0" member_type: VOTER last_known_addr { host: "127.11.73.2" port: 36485 } } peers { permanent_uuid: "a862250c606c43a09fcd6eb34736359d" member_type: VOTER last_known_addr { host: "127.11.73.3" port: 39789 } } peers { permanent_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" member_type: VOTER last_known_addr { host: "127.11.73.1" port: 44167 } }
20:03:25.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.400417 12358 raft_consensus.cc:385] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:25.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.401023 12358 raft_consensus.cc:740] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 5f319514b7db4bf7ba03831620f4b1e0, State: Initialized, Role: FOLLOWER
20:03:25.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.402818 12358 consensus_queue.cc:260] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0 [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: "5f319514b7db4bf7ba03831620f4b1e0" member_type: VOTER last_known_addr { host: "127.11.73.2" port: 36485 } } peers { permanent_uuid: "a862250c606c43a09fcd6eb34736359d" member_type: VOTER last_known_addr { host: "127.11.73.3" port: 39789 } } peers { permanent_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" member_type: VOTER last_known_addr { host: "127.11.73.1" port: 44167 } }
20:03:25.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.404942 12359 raft_consensus.cc:359] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5f319514b7db4bf7ba03831620f4b1e0" member_type: VOTER last_known_addr { host: "127.11.73.2" port: 36485 } } peers { permanent_uuid: "a862250c606c43a09fcd6eb34736359d" member_type: VOTER last_known_addr { host: "127.11.73.3" port: 39789 } } peers { permanent_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" member_type: VOTER last_known_addr { host: "127.11.73.1" port: 44167 } }
20:03:25.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.406314 12359 raft_consensus.cc:385] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:25.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.406963 12359 raft_consensus.cc:740] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: a862250c606c43a09fcd6eb34736359d, State: Initialized, Role: FOLLOWER
20:03:25.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.412459 12359 consensus_queue.cc:260] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [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: "5f319514b7db4bf7ba03831620f4b1e0" member_type: VOTER last_known_addr { host: "127.11.73.2" port: 36485 } } peers { permanent_uuid: "a862250c606c43a09fcd6eb34736359d" member_type: VOTER last_known_addr { host: "127.11.73.3" port: 39789 } } peers { permanent_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" member_type: VOTER last_known_addr { host: "127.11.73.1" port: 44167 } }
20:03:25.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.432548 12359 ts_tablet_manager.cc:1434] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d: Time spent starting tablet: real 0.089s	user 0.048s	sys 0.036s
20:03:25.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.458542 12360 raft_consensus.cc:359] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5f319514b7db4bf7ba03831620f4b1e0" member_type: VOTER last_known_addr { host: "127.11.73.2" port: 36485 } } peers { permanent_uuid: "a862250c606c43a09fcd6eb34736359d" member_type: VOTER last_known_addr { host: "127.11.73.3" port: 39789 } } peers { permanent_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" member_type: VOTER last_known_addr { host: "127.11.73.1" port: 44167 } }
20:03:25.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.470227 12360 raft_consensus.cc:385] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:25.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.470988 12360 raft_consensus.cc:740] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 9cf8ea7cda234640bd5597e1f35e9d1c, State: Initialized, Role: FOLLOWER
20:03:25.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.473091 12360 consensus_queue.cc:260] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c [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: "5f319514b7db4bf7ba03831620f4b1e0" member_type: VOTER last_known_addr { host: "127.11.73.2" port: 36485 } } peers { permanent_uuid: "a862250c606c43a09fcd6eb34736359d" member_type: VOTER last_known_addr { host: "127.11.73.3" port: 39789 } } peers { permanent_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" member_type: VOTER last_known_addr { host: "127.11.73.1" port: 44167 } }
20:03:25.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.483206 12358 ts_tablet_manager.cc:1434] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0: Time spent starting tablet: real 0.141s	user 0.052s	sys 0.075s
20:03:25.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:25.492146 12179 tablet.cc:2406] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:03:25.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.516136 12360 ts_tablet_manager.cc:1434] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c: Time spent starting tablet: real 0.135s	user 0.031s	sys 0.056s
20:03:25.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:25.555939 12329 tablet.cc:2406] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:03:25.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.557008 12365 raft_consensus.cc:493] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
20:03:25.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.558224 12365 raft_consensus.cc:515] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5f319514b7db4bf7ba03831620f4b1e0" member_type: VOTER last_known_addr { host: "127.11.73.2" port: 36485 } } peers { permanent_uuid: "a862250c606c43a09fcd6eb34736359d" member_type: VOTER last_known_addr { host: "127.11.73.3" port: 39789 } } peers { permanent_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" member_type: VOTER last_known_addr { host: "127.11.73.1" port: 44167 } }
20:03:25.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.585868 12365 leader_election.cc:290] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 5f319514b7db4bf7ba03831620f4b1e0 (127.11.73.2:36485), 9cf8ea7cda234640bd5597e1f35e9d1c (127.11.73.1:44167)
20:03:25.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 20:03:25.609854 12035 tablet.cc:2406] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:03:25.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.642671 11977 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "8831ed7159d14a68afaa6feffb2dd402" candidate_uuid: "a862250c606c43a09fcd6eb34736359d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" is_pre_election: true
20:03:25.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.643802 11977 raft_consensus.cc:2468] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate a862250c606c43a09fcd6eb34736359d in term 0.
20:03:25.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.645927 12200 leader_election.cc:304] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [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: 9cf8ea7cda234640bd5597e1f35e9d1c, a862250c606c43a09fcd6eb34736359d; no voters: 
20:03:25.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.647557 12365 raft_consensus.cc:2804] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [term 0 FOLLOWER]: Leader pre-election won for term 1
20:03:25.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.647943 12365 raft_consensus.cc:493] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
20:03:25.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.648280 12365 raft_consensus.cc:3060] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [term 0 FOLLOWER]: Advancing to term 1
20:03:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.652676 12126 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "8831ed7159d14a68afaa6feffb2dd402" candidate_uuid: "a862250c606c43a09fcd6eb34736359d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5f319514b7db4bf7ba03831620f4b1e0" is_pre_election: true
20:03:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.653789 12126 raft_consensus.cc:2468] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate a862250c606c43a09fcd6eb34736359d in term 0.
20:03:25.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.658807 12365 raft_consensus.cc:515] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5f319514b7db4bf7ba03831620f4b1e0" member_type: VOTER last_known_addr { host: "127.11.73.2" port: 36485 } } peers { permanent_uuid: "a862250c606c43a09fcd6eb34736359d" member_type: VOTER last_known_addr { host: "127.11.73.3" port: 39789 } } peers { permanent_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" member_type: VOTER last_known_addr { host: "127.11.73.1" port: 44167 } }
20:03:25.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.660785 12365 leader_election.cc:290] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [CANDIDATE]: Term 1 election: Requested vote from peers 5f319514b7db4bf7ba03831620f4b1e0 (127.11.73.2:36485), 9cf8ea7cda234640bd5597e1f35e9d1c (127.11.73.1:44167)
20:03:25.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.661711 12126 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "8831ed7159d14a68afaa6feffb2dd402" candidate_uuid: "a862250c606c43a09fcd6eb34736359d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5f319514b7db4bf7ba03831620f4b1e0"
20:03:25.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.662295 12126 raft_consensus.cc:3060] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0 [term 0 FOLLOWER]: Advancing to term 1
20:03:25.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.662212 11977 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "8831ed7159d14a68afaa6feffb2dd402" candidate_uuid: "a862250c606c43a09fcd6eb34736359d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c"
20:03:25.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.662859 11977 raft_consensus.cc:3060] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c [term 0 FOLLOWER]: Advancing to term 1
20:03:25.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.668650 12126 raft_consensus.cc:2468] T 8831ed7159d14a68afaa6feffb2dd402 P 5f319514b7db4bf7ba03831620f4b1e0 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate a862250c606c43a09fcd6eb34736359d in term 1.
20:03:25.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.670189 12200 leader_election.cc:304] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [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: 5f319514b7db4bf7ba03831620f4b1e0, a862250c606c43a09fcd6eb34736359d; no voters: 
20:03:25.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.671180 12365 raft_consensus.cc:2804] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [term 1 FOLLOWER]: Leader election won for term 1
20:03:25.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.673391 11977 raft_consensus.cc:2468] T 8831ed7159d14a68afaa6feffb2dd402 P 9cf8ea7cda234640bd5597e1f35e9d1c [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate a862250c606c43a09fcd6eb34736359d in term 1.
20:03:25.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.676476 12365 raft_consensus.cc:697] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [term 1 LEADER]: Becoming Leader. State: Replica: a862250c606c43a09fcd6eb34736359d, State: Running, Role: LEADER
20:03:25.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.678264 12365 consensus_queue.cc:237] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [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: "5f319514b7db4bf7ba03831620f4b1e0" member_type: VOTER last_known_addr { host: "127.11.73.2" port: 36485 } } peers { permanent_uuid: "a862250c606c43a09fcd6eb34736359d" member_type: VOTER last_known_addr { host: "127.11.73.3" port: 39789 } } peers { permanent_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" member_type: VOTER last_known_addr { host: "127.11.73.1" port: 44167 } }
20:03:25.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:25.704222 11772 catalog_manager.cc:5719] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d reported cstate change: term changed from 0 to 1, leader changed from <none> to a862250c606c43a09fcd6eb34736359d (127.11.73.3). New cstate: current_term: 1 leader_uuid: "a862250c606c43a09fcd6eb34736359d" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5f319514b7db4bf7ba03831620f4b1e0" member_type: VOTER last_known_addr { host: "127.11.73.2" port: 36485 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "a862250c606c43a09fcd6eb34736359d" member_type: VOTER last_known_addr { host: "127.11.73.3" port: 39789 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" member_type: VOTER last_known_addr { host: "127.11.73.1" port: 44167 } health_report { overall_health: UNKNOWN } } }
20:03:26.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:26.078717 12365 consensus_queue.cc:1048] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [LEADER]: Connected to new peer: Peer: permanent_uuid: "9cf8ea7cda234640bd5597e1f35e9d1c" member_type: VOTER last_known_addr { host: "127.11.73.1" port: 44167 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
20:03:26.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:26.103462 12387 consensus_queue.cc:1048] T 8831ed7159d14a68afaa6feffb2dd402 P a862250c606c43a09fcd6eb34736359d [LEADER]: Connected to new peer: Peer: permanent_uuid: "5f319514b7db4bf7ba03831620f4b1e0" member_type: VOTER last_known_addr { host: "127.11.73.2" port: 36485 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
20:03:26.232 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet 8831ed7159d14a68afaa6feffb2dd402 for table 'org.apache.kudu.client.TestHybridTime-1786478582821' with partition [<start>, <end>)
20:03:26.239 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=8831ed7159d14a68afaa6feffb2dd402@[5f319514b7db4bf7ba03831620f4b1e0(127.11.73.2:36485),9cf8ea7cda234640bd5597e1f35e9d1c(127.11.73.1:44167),a862250c606c43a09fcd6eb34736359d(127.11.73.3:39789)[L]]}]
20:03:26.241 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=21), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.11.73.60:46687, [10ms] Sub RPC GetTableLocations: received response from server master-127.11.73.60:46687: OK, deferred=null) after lookup
20:03:26.252 [DEBUG - kudu-nio-2] (Connection.java:748) [peer a862250c606c43a09fcd6eb34736359d(127.11.73.3:39789)] connecting to peer
20:03:26.255 [DEBUG - kudu-nio-3] (Connection.java:757) [peer a862250c606c43a09fcd6eb34736359d(127.11.73.3:39789)] Successfully connected to peer
20:03:26.326 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0xf54db5d1, L:/127.0.0.1:56240 - R:/127.11.73.3:39789] using TOKEN/null
20:03:26.415 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:26.443 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:26.483 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:26.489 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@974722333(state=PENDING, result=null, callback=<none>, errback=<none>)}
20:03:26.563 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:26.564 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@855862675(state=PENDING, result=null, callback=<none>, errback=<none>)}
20:03:26.617 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:26.618 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1474650842(state=PENDING, result=null, callback=<none>, errback=<none>)}
20:03:26.661 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:26.847 [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-1786478582821, tablet=8831ed7159d14a68afaa6feffb2dd402, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:26.869 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7317416392032112641) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786478582821, tablet=8831ed7159d14a68afaa6feffb2dd402, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:26.890 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7317416392032112645) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786478582821, tablet=8831ed7159d14a68afaa6feffb2dd402, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:26.910 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7317416392032112649) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786478582821, tablet=8831ed7159d14a68afaa6feffb2dd402, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:26.930 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7317416392032112653) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786478582821, tablet=8831ed7159d14a68afaa6feffb2dd402, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:26.949 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7317416392032112659) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786478582821, tablet=8831ed7159d14a68afaa6feffb2dd402, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:26.971 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7317416392032112662) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786478582821, tablet=8831ed7159d14a68afaa6feffb2dd402, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:26.992 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7317416392032112663) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786478582821, tablet=8831ed7159d14a68afaa6feffb2dd402, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:26.996 [DEBUG - main] (Connection.java:575) [peer master-127.11.73.60:46687(127.11.73.60:46687)] disconnecting while in state READY
20:03:26.997 [DEBUG - main] (Connection.java:575) [peer a862250c606c43a09fcd6eb34736359d(127.11.73.3:39789)] disconnecting while in state READY
20:03:26.997 [DEBUG - main] (Connection.java:575) [peer master-127.11.73.61:40409(127.11.73.61:40409)] disconnecting while in state READY
20:03:26.997 [DEBUG - main] (Connection.java:575) [peer master-127.11.73.62:41783(127.11.73.62:41783)] disconnecting while in state READY
20:03:27.002 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.11.73.62:41783(127.11.73.62:41783)] handling channelInactive
20:03:27.003 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.11.73.61:40409(127.11.73.61:40409)] handling channelInactive
20:03:27.003 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.11.73.62:41783(127.11.73.62:41783)] cleaning up while in state READY due to: connection closed
20:03:27.003 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.11.73.61:40409(127.11.73.61:40409)] cleaning up while in state READY due to: connection closed
20:03:27.006 [DEBUG - kudu-nio-3] (Connection.java:239) [peer a862250c606c43a09fcd6eb34736359d(127.11.73.3:39789)] handling channelInactive
20:03:27.006 [DEBUG - kudu-nio-3] (Connection.java:709) [peer a862250c606c43a09fcd6eb34736359d(127.11.73.3:39789)] cleaning up while in state READY due to: connection closed
20:03:27.008 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2704) Releasing all remaining resources
20:03:27.016 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.11.73.60:46687(127.11.73.60:46687)] handling channelInactive
20:03:27.016 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.11.73.60:46687(127.11.73.60:46687)] cleaning up while in state READY due to: connection closed
20:03:27.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:27.016021 11556 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu with pid 11882
20:03:27.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:27.063318 11556 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu with pid 12026
20:03:27.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:27.109978 11556 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu with pid 12182
20:03:27.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:27.150206 11556 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu with pid 11568
20:03:27.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:27.185972 11556 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu with pid 11644
20:03:27.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 20:03:27.218271 11556 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskOcLkUh/build/tsan/bin/kudu with pid 11723
20:03:28.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T20:03:28Z chronyd exiting

Time: 26.859

OK (1 test)

