JUnit version 4.13.2
.02:11:46.232 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783476706221
02:11:46.257 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
02:11:46.295 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
02:11:46.306 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskU3NM2m/test-tmp
02:11:46.338 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
02:11:46.342 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskU3NM2m/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
02:11:46.577 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

02:11:46.759 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
02:11:46.760 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

02:11:46.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:46.764355 13810 mini_oidc.cc:150] Starting JWKS server
02:11:46.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:46.768069 13810 webserver.cc:534] Webserver started at http://127.0.0.1:43205/ using document root <none> and password file <none>
02:11:46.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:46.768667 13810 mini_oidc.cc:186] Starting OIDC Discovery server
02:11:46.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:46.771166 13810 webserver.cc:534] Webserver started at http://127.0.0.1:41845/ using document root <none> and password file <none>
02:11:46.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:11:46Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
02:11:46.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:11:46Z Disabled control of system clock
02:11:46.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:46.837958 13810 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:11:46.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:11:46.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/wal
02:11:46.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/data
02:11:46.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:11:46.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:11:46.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:11:46.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:46.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:46.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:46.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/logs
02:11:46.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/data/info.pb
02:11:46.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:46.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:11:46.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:11:46.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:11:46.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:11:46.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:46.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:46.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:46.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:11:46.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:11:46.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:46.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:46.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.190:42891
02:11:46.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.190
02:11:46.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:46.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:11:46.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:46.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:46.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:46.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:46.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:11:46.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:46.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43205/jwks.json with env {}
02:11:47.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:47.152032 13822 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:11:47.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:47.152627 13822 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:11:47.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:47.153159 13822 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:11:47.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:47.186306 13822 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:11:47.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:47.186674 13822 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:11:47.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:47.186880 13822 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:11:47.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:47.187069 13822 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:11:47.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:47.187343 13822 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:11:47.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:47.187595 13822 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:43205/jwks.json
02:11:47.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:47.225487 13822 master_runner.cc:387] Master server non-default flags:
02:11:47.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:47.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:11:47.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:47.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:47.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/data
02:11:47.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/wal
02:11:47.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:47.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:11:47.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:47.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:47.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:47.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.190:42891
02:11:47.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:47.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:11:47.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:47.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43205/jwks.json
02:11:47.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:47.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:47.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/data/info.pb
02:11:47.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.190
02:11:47.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:47.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:11:47.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:47.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:11:47.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:11:47.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:47.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/logs
02:11:47.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:47.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:11:47.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:11:47.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:11:47.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:11:47.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:11:47.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:11:47.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on e7f111948823
02:11:47.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16850
02:11:47.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:11:47.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:47.227214 13822 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:11:47.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:47.229271 13822 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:11:47.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:47.242507 13828 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
02:11:48.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:47.243930 13829 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
02:11:48.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:48.582854 13831 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
02:11:48.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:48.587232 13830 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1342 milliseconds
02:11:48.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:48.587885 13822 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.345s	user 0.398s	sys 0.943s
02:11:48.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:48.588205 13822 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.346s	user 0.398s	sys 0.943s
02:11:48.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.588466 13822 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
02:11:48.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.589851 13822 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:11:48.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.592784 13822 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:11:48.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.594290 13822 hybrid_clock.cc:648] HybridClock initialized: now 1783476708594208 us; error 99 us; skew 500 ppm
02:11:48.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.595381 13822 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:11:48.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.603188 13822 webserver.cc:534] Webserver started at http://127.13.124.190:43469/ using document root <none> and password file <none>
02:11:48.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.604442 13822 fs_manager.cc:362] Metadata directory not provided
02:11:48.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.604703 13822 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:11:48.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.605286 13822 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:11:48.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.609901 13822 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/data/instance:
02:11:48.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fc8e74ddac984cadaadc2bfcaf37a026"
02:11:48.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:48 on dist-test-slave-tzf0"
02:11:48.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.611445 13822 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/wal/instance:
02:11:48.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fc8e74ddac984cadaadc2bfcaf37a026"
02:11:48.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:48 on dist-test-slave-tzf0"
02:11:48.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.619887 13822 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.006s	sys 0.002s
02:11:48.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.626245 13838 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:11:48.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.628489 13822 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.003s	sys 0.000s
02:11:48.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.628924 13822 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/data,/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/wal
02:11:48.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fc8e74ddac984cadaadc2bfcaf37a026"
02:11:48.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:48 on dist-test-slave-tzf0"
02:11:48.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.629418 13822 fs_report.cc:389] FS layout report
02:11:48.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:11:48.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/wal
02:11:48.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/wal
02:11:48.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/data/data
02:11:48.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:11:48.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:11:48.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:11:48.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:11:48.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:11:48.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:11:48.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:11:48.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:11:48.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:11:48.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:11:48.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:11:48.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.708847 13822 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:11:48.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.710655 13822 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:11:48.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.711162 13822 kserver.cc:163] Server-wide thread pool size limit: 3276
02:11:48.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.782110 13822 rpc_server.cc:307] RPC server started. Bound to: 127.13.124.190:42891
02:11:48.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.782217 13889 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.124.190:42891 every 8 connection(s)
02:11:48.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.785198 13822 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/data/info.pb
02:11:48.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.790392 13810 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu as pid 13822
02:11:48.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.790946 13810 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-0/wal/instance
02:11:48.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.791641 13890 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
02:11:48.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.794740 13810 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:11:48.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:11:48.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/wal
02:11:48.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/data
02:11:48.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:11:48.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:11:48.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:11:48.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:48.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:48.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:48.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/logs
02:11:48.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/data/info.pb
02:11:48.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:48.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:11:48.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:11:48.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:11:48.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:11:48.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:48.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:48.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:48.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:11:48.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:11:48.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:48.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:48.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.189:36301
02:11:48.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.189
02:11:48.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:48.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:11:48.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:48.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:48.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:48.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:48.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:11:48.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:48.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43205/jwks.json with env {}
02:11:48.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.805590 13890 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } has no permanent_uuid. Determining permanent_uuid...
02:11:48.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.837234 13890 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } has no permanent_uuid. Determining permanent_uuid...
02:11:48.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:48.840382 13841 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.124.189:36301: connect: Connection refused (error 111)
02:11:48.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:48.845112 13890 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.189:36301: Network error: Client connection negotiation failed: client connection to 127.13.124.189:36301: connect: Connection refused (error 111)
02:11:48.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.894660 13890 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } attempt: 1
02:11:48.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:48.899245 13890 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.189:36301: Network error: Client connection negotiation failed: client connection to 127.13.124.189:36301: connect: Connection refused (error 111)
02:11:48.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:48.967806 13890 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } attempt: 2
02:11:48.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:48.974220 13890 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.189:36301: Network error: Client connection negotiation failed: client connection to 127.13.124.189:36301: connect: Connection refused (error 111)
02:11:49.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:49.065744 13890 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } attempt: 3
02:11:49.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.071305 13890 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.189:36301: Network error: Client connection negotiation failed: client connection to 127.13.124.189:36301: connect: Connection refused (error 111)
02:11:49.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.136142 13892 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:11:49.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.136703 13892 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:11:49.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.137472 13892 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:11:49.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.178287 13892 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:11:49.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.178598 13892 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:11:49.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.178802 13892 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:11:49.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.179005 13892 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:11:49.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.179291 13892 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:11:49.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.179447 13892 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:43205/jwks.json
02:11:49.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:49.214828 13890 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } attempt: 4
02:11:49.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:49.217675 13892 master_runner.cc:387] Master server non-default flags:
02:11:49.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:49.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:11:49.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:49.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:49.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/data
02:11:49.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/wal
02:11:49.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:49.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:11:49.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:49.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:49.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:49.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.189:36301
02:11:49.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:49.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:11:49.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:49.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43205/jwks.json
02:11:49.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:49.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:49.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/data/info.pb
02:11:49.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.189
02:11:49.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:49.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:11:49.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:49.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:11:49.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:11:49.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:49.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/logs
02:11:49.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:49.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:11:49.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:11:49.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:11:49.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:11:49.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:11:49.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:11:49.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on e7f111948823
02:11:49.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16850
02:11:49.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:11:49.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:49.219480 13892 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:11:49.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.220221 13890 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.189:36301: Network error: Client connection negotiation failed: client connection to 127.13.124.189:36301: connect: Connection refused (error 111)
02:11:49.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:49.221320 13892 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:11:49.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.235630 13901 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
02:11:49.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:49.519675 13890 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } attempt: 5
02:11:49.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.527920 13890 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.189:36301: Network error: Client connection negotiation failed: client connection to 127.13.124.189:36301: connect: Connection refused (error 111)
02:11:50.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:50.075518 13890 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } attempt: 6
02:11:50.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:50.107897 13890 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.189:36301: Network error: Client connection negotiation failed: client connection to 127.13.124.189:36301: connect: Connection refused (error 111)
02:11:51.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:50.639020 13900 debug-util.cc:398] Leaking SignalData structure 0x7b0800028020 after lost signal to thread 13892
02:11:51.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.092478 13900 kernel_stack_watchdog.cc:198] Thread 13892 stuck at /home/jenkins-slave/workspace/build_and_test@2/src/kudu/util/thread.cc:642 for 400ms:
02:11:51.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
02:11:51.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
02:11:51.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
02:11:51.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
02:11:51.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:49.236397 13902 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
02:11:51.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.094520 13892 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.859s	user 0.682s	sys 1.167s
02:11:51.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.095293 13892 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.860s	user 0.683s	sys 1.167s
02:11:51.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.096423 13904 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
02:11:51.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.099985 13903 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection timed out after 1863 milliseconds
02:11:51.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.100073 13892 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
02:11:51.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.102026 13892 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:11:51.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.104908 13892 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:11:51.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.106402 13892 hybrid_clock.cc:648] HybridClock initialized: now 1783476711106362 us; error 46 us; skew 500 ppm
02:11:51.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.107585 13892 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:11:51.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.114248 13892 webserver.cc:534] Webserver started at http://127.13.124.189:44141/ using document root <none> and password file <none>
02:11:51.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.115394 13892 fs_manager.cc:362] Metadata directory not provided
02:11:51.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.115653 13892 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:11:51.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.116258 13892 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:11:51.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.120749 13892 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/data/instance:
02:11:51.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3160347332514456b2d9c39525d4acb3"
02:11:51.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:51 on dist-test-slave-tzf0"
02:11:51.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.122188 13892 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/wal/instance:
02:11:51.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3160347332514456b2d9c39525d4acb3"
02:11:51.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:51 on dist-test-slave-tzf0"
02:11:51.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.129715 13892 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.006s	sys 0.000s
02:11:51.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.136893 13913 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:11:51.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.138263 13892 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.004s	sys 0.002s
02:11:51.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.138741 13892 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/data,/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/wal
02:11:51.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3160347332514456b2d9c39525d4acb3"
02:11:51.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:51 on dist-test-slave-tzf0"
02:11:51.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.139254 13892 fs_report.cc:389] FS layout report
02:11:51.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:11:51.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/wal
02:11:51.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/wal
02:11:51.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/data/data
02:11:51.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:11:51.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:11:51.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:11:51.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:11:51.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:11:51.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:11:51.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:11:51.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:11:51.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:11:51.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:11:51.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:11:51.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.168421 13890 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } attempt: 7
02:11:51.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.175796 13890 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.189:36301: Network error: Client connection negotiation failed: client connection to 127.13.124.189:36301: connect: Connection refused (error 111)
02:11:51.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.198681 13892 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:11:51.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.200384 13892 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:11:51.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.200834 13892 kserver.cc:163] Server-wide thread pool size limit: 3276
02:11:51.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.278959 13892 rpc_server.cc:307] RPC server started. Bound to: 127.13.124.189:36301
02:11:51.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.278985 13966 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.124.189:36301 every 8 connection(s)
02:11:51.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.282001 13892 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/data/info.pb
02:11:51.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.289650 13967 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
02:11:51.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.290459 13810 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu as pid 13892
02:11:51.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.291006 13810 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-1/wal/instance
02:11:51.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.293301 13810 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:11:51.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:11:51.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/wal
02:11:51.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/data
02:11:51.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:11:51.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:11:51.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:11:51.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:51.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:51.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:51.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/logs
02:11:51.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/data/info.pb
02:11:51.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:51.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:11:51.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:11:51.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:11:51.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:11:51.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:51.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:51.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:51.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:11:51.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:11:51.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:51.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:51.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.188:43145
02:11:51.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.188
02:11:51.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:51.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:11:51.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:51.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:51.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:51.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:51.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:11:51.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:51.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43205/jwks.json with env {}
02:11:51.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.306740 13967 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } has no permanent_uuid. Determining permanent_uuid...
02:11:51.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.334776 13967 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } has no permanent_uuid. Determining permanent_uuid...
02:11:51.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.351009 13967 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } has no permanent_uuid. Determining permanent_uuid...
02:11:51.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.353621 13919 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.124.188:43145: connect: Connection refused (error 111)
02:11:51.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.358043 13967 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.188:43145: Network error: Client connection negotiation failed: client connection to 127.13.124.188:43145: connect: Connection refused (error 111)
02:11:51.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.407727 13967 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } attempt: 1
02:11:51.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.412804 13967 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.188:43145: Network error: Client connection negotiation failed: client connection to 127.13.124.188:43145: connect: Connection refused (error 111)
02:11:51.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.481325 13967 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } attempt: 2
02:11:51.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.486442 13967 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.188:43145: Network error: Client connection negotiation failed: client connection to 127.13.124.188:43145: connect: Connection refused (error 111)
02:11:51.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.578027 13967 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } attempt: 3
02:11:51.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.582572 13967 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.188:43145: Network error: Client connection negotiation failed: client connection to 127.13.124.188:43145: connect: Connection refused (error 111)
02:11:51.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.646766 13969 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:11:51.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.647395 13969 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:11:51.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.647840 13969 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:11:51.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.680577 13969 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:11:51.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.681015 13969 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:11:51.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.681346 13969 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:11:51.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.681705 13969 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:11:51.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.682128 13969 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:11:51.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.682405 13969 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:43205/jwks.json
02:11:51.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.720736 13969 master_runner.cc:387] Master server non-default flags:
02:11:51.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:51.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:11:51.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:51.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:51.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/data
02:11:51.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/wal
02:11:51.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:51.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:11:51.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:51.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:51.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:51.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.188:43145
02:11:51.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:51.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:11:51.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:51.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43205/jwks.json
02:11:51.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:51.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:51.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/data/info.pb
02:11:51.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.188
02:11:51.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:51.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:11:51.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:51.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:11:51.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:11:51.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:51.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/logs
02:11:51.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:51.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:11:51.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:11:51.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:11:51.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:11:51.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:11:51.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:11:51.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on e7f111948823
02:11:51.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16850
02:11:51.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:11:51.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.722563 13969 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:11:51.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.724946 13969 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:11:51.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:51.726042 13967 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } attempt: 4
02:11:51.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.731388 13967 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.188:43145: Network error: Client connection negotiation failed: client connection to 127.13.124.188:43145: connect: Connection refused (error 111)
02:11:51.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.737783 13979 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
02:11:52.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:52.030807 13967 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } attempt: 5
02:11:52.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:52.040017 13967 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.188:43145: Network error: Client connection negotiation failed: client connection to 127.13.124.188:43145: connect: Connection refused (error 111)
02:11:52.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:52.587642 13967 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } attempt: 6
02:11:52.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:52.616200 13967 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.188:43145: Network error: Client connection negotiation failed: client connection to 127.13.124.188:43145: connect: Connection refused (error 111)
02:11:53.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.142532 13978 debug-util.cc:398] Leaking SignalData structure 0x7b0800028020 after lost signal to thread 13969
02:11:53.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.151903 13969 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.413s	user 0.426s	sys 0.972s
02:11:53.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.152406 13969 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.414s	user 0.426s	sys 0.972s
02:11:53.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:51.739401 13980 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
02:11:53.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.154687 13982 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
02:11:53.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.157636 13981 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1415 milliseconds
02:11:53.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.157676 13969 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
02:11:53.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.159128 13969 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:11:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.161513 13969 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:11:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.162849 13969 hybrid_clock.cc:648] HybridClock initialized: now 1783476713162822 us; error 37 us; skew 500 ppm
02:11:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.163640 13969 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:11:53.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.170105 13969 webserver.cc:534] Webserver started at http://127.13.124.188:39413/ using document root <none> and password file <none>
02:11:53.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.171098 13969 fs_manager.cc:362] Metadata directory not provided
02:11:53.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.171357 13969 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:11:53.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.171934 13969 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:11:53.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.176388 13969 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/data/instance:
02:11:53.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "214004c65d664b44800d9e3bbe0219c3"
02:11:53.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:53 on dist-test-slave-tzf0"
02:11:53.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.177767 13969 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/wal/instance:
02:11:53.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "214004c65d664b44800d9e3bbe0219c3"
02:11:53.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:53 on dist-test-slave-tzf0"
02:11:53.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.186623 13969 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.006s	sys 0.001s
02:11:53.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.193240 13991 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:11:53.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.194626 13969 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.006s
02:11:53.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.195034 13969 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/data,/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/wal
02:11:53.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "214004c65d664b44800d9e3bbe0219c3"
02:11:53.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:53 on dist-test-slave-tzf0"
02:11:53.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.195500 13969 fs_report.cc:389] FS layout report
02:11:53.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:11:53.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/wal
02:11:53.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/wal
02:11:53.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/data/data
02:11:53.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:11:53.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:11:53.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:11:53.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:11:53.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:11:53.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:11:53.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:11:53.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:11:53.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:11:53.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:11:53.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:11:53.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.248797 13969 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:11:53.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.250627 13969 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:11:53.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.251176 13969 kserver.cc:163] Server-wide thread pool size limit: 3276
02:11:53.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.266382 13890 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } attempt: 8
02:11:53.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.282111 13890 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } has no permanent_uuid. Determining permanent_uuid...
02:11:53.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.292098 13890 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.124.188:43145: Network error: Client connection negotiation failed: client connection to 127.13.124.188:43145: connect: Connection refused (error 111)
02:11:53.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.347769 13969 rpc_server.cc:307] RPC server started. Bound to: 127.13.124.188:43145
02:11:53.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.347895 14045 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.124.188:43145 every 8 connection(s)
02:11:53.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.350744 13969 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/data/info.pb
02:11:53.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.351297 13810 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu as pid 13969
02:11:53.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.351805 13810 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/master-2/wal/instance
02:11:53.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.357583 13890 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } attempt: 1
02:11:53.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.359439 14046 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
02:11:53.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.384788 14046 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } has no permanent_uuid. Determining permanent_uuid...
02:11:53.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.412088 14046 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } has no permanent_uuid. Determining permanent_uuid...
02:11:53.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.414811 13890 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026: Bootstrap starting.
02:11:53.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.422322 13890 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026: Neither blocks nor log segments found. Creating new log.
02:11:53.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.424882 13890 log.cc:826] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026: Log is configured to *not* fsync() on all Append() calls
02:11:53.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.427016 14046 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } has no permanent_uuid. Determining permanent_uuid...
02:11:53.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.430995 13890 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026: No bootstrap required, opened a new log
02:11:53.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.446884 14046 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3: Bootstrap starting.
02:11:53.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.455175 14046 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3: Neither blocks nor log segments found. Creating new log.
02:11:53.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.455441 13890 raft_consensus.cc:359] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } }
02:11:53.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.456287 13890 raft_consensus.cc:385] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:11:53.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.456492 13890 raft_consensus.cc:740] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: fc8e74ddac984cadaadc2bfcaf37a026, State: Initialized, Role: FOLLOWER
02:11:53.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.457309 13890 consensus_queue.cc:260] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [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: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } }
02:11:53.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.457743 14046 log.cc:826] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3: Log is configured to *not* fsync() on all Append() calls
02:11:53.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.460381 14054 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [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: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } } }
02:11:53.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.461421 14054 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [sys.catalog]: This master's current role is: FOLLOWER
02:11:53.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.462334 13890 sys_catalog.cc:565] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [sys.catalog]: configured and running, proceeding with master startup.
02:11:53.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.464136 14046 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3: No bootstrap required, opened a new log
02:11:53.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.472548 13844 tablet.cc:2406] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:11:53.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.492276 14046 raft_consensus.cc:359] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } }
02:11:53.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.494050 14046 raft_consensus.cc:385] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:11:53.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.494896 14046 raft_consensus.cc:740] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 214004c65d664b44800d9e3bbe0219c3, State: Initialized, Role: FOLLOWER
02:11:53.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.496348 14046 consensus_queue.cc:260] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [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: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } }
02:11:53.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.500036 14067 sys_catalog.cc:455] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [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: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } } }
02:11:53.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.501215 14067 sys_catalog.cc:458] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [sys.catalog]: This master's current role is: FOLLOWER
02:11:53.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.502236 14046 sys_catalog.cc:565] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [sys.catalog]: configured and running, proceeding with master startup.
02:11:53.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.506908 13997 tablet.cc:2406] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:11:53.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.526590 14066 catalog_manager.cc:1593] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:11:53.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.527992 14066 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:11:53.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.512462 13822 master_runner.cc:187] Error getting master registration for 127.13.124.189:36301: OK, instance_id { permanent_uuid: "3160347332514456b2d9c39525d4acb3" instance_seqno: 1783476711258230 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
02:11:53.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.544638 13822 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:11:53.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.556463 14079 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:11:53.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.557334 14079 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:11:53.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.557497 13969 master_runner.cc:187] Error getting master registration for 127.13.124.189:36301: OK, instance_id { permanent_uuid: "3160347332514456b2d9c39525d4acb3" instance_seqno: 1783476711258230 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
02:11:53.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.581571 13969 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:11:53.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.676786 13967 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } attempt: 7
02:11:53.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.701084 13967 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3: Bootstrap starting.
02:11:53.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.710212 13967 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3: Neither blocks nor log segments found. Creating new log.
02:11:53.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.712755 13967 log.cc:826] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3: Log is configured to *not* fsync() on all Append() calls
02:11:53.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.718425 13967 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3: No bootstrap required, opened a new log
02:11:53.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.749709 13967 raft_consensus.cc:359] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } }
02:11:53.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.750700 13967 raft_consensus.cc:385] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:11:53.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.751010 13967 raft_consensus.cc:740] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3160347332514456b2d9c39525d4acb3, State: Initialized, Role: FOLLOWER
02:11:53.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.752349 13967 consensus_queue.cc:260] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [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: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } }
02:11:53.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.759213 13967 sys_catalog.cc:565] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [sys.catalog]: configured and running, proceeding with master startup.
02:11:53.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.765718 14083 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [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: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } } }
02:11:53.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.767114 14083 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [sys.catalog]: This master's current role is: FOLLOWER
02:11:53.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.808981 14094 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
02:11:53.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.829387 14054 raft_consensus.cc:493] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:11:53.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.829998 14054 raft_consensus.cc:515] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } }
02:11:53.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.839855 14021 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "214004c65d664b44800d9e3bbe0219c3" is_pre_election: true
02:11:53.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.840451 14067 raft_consensus.cc:493] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:11:53.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.840997 14067 raft_consensus.cc:515] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } }
02:11:53.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.842978 13942 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3160347332514456b2d9c39525d4acb3" is_pre_election: true
02:11:53.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.843842 13942 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate fc8e74ddac984cadaadc2bfcaf37a026 in term 0.
02:11:53.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.844823 14021 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate fc8e74ddac984cadaadc2bfcaf37a026 in term 0.
02:11:53.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.845403 13865 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "214004c65d664b44800d9e3bbe0219c3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" is_pre_election: true
02:11:53.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.846161 13865 raft_consensus.cc:2468] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 214004c65d664b44800d9e3bbe0219c3 in term 0.
02:11:53.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.847721 13995 leader_election.cc:304] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [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: 214004c65d664b44800d9e3bbe0219c3, fc8e74ddac984cadaadc2bfcaf37a026; no voters: 
02:11:53.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.850024 13841 leader_election.cc:304] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [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: 3160347332514456b2d9c39525d4acb3, fc8e74ddac984cadaadc2bfcaf37a026; no voters: 
02:11:53.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.851518 14067 leader_election.cc:290] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers fc8e74ddac984cadaadc2bfcaf37a026 (127.13.124.190:42891), 3160347332514456b2d9c39525d4acb3 (127.13.124.189:36301)
02:11:53.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.852062 13942 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "214004c65d664b44800d9e3bbe0219c3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3160347332514456b2d9c39525d4acb3" is_pre_election: true
02:11:53.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.852662 13942 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 214004c65d664b44800d9e3bbe0219c3 in term 0.
02:11:53.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.855199 13892 master_runner.cc:264] No leader master found from master 3160347332514456b2d9c39525d4acb3
02:11:53.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.855535 13892 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:11:53.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.855827 14054 leader_election.cc:290] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 3160347332514456b2d9c39525d4acb3 (127.13.124.189:36301), 214004c65d664b44800d9e3bbe0219c3 (127.13.124.188:43145)
02:11:53.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.856353 14054 raft_consensus.cc:2804] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 0 FOLLOWER]: Leader pre-election won for term 1
02:11:53.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.856700 14054 raft_consensus.cc:493] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
02:11:53.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.857041 14054 raft_consensus.cc:3060] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 0 FOLLOWER]: Advancing to term 1
02:11:53.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.861994 14067 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 0 FOLLOWER]: Leader pre-election won for term 1
02:11:53.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.862380 14067 raft_consensus.cc:493] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
02:11:53.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.862743 14067 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 0 FOLLOWER]: Advancing to term 1
02:11:53.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.868045 14054 raft_consensus.cc:515] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } }
02:11:53.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.881618 13942 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3160347332514456b2d9c39525d4acb3"
02:11:53.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.882236 13942 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [term 0 FOLLOWER]: Advancing to term 1
02:11:53.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.882405 14067 raft_consensus.cc:515] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } }
02:11:53.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.885684 13941 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "214004c65d664b44800d9e3bbe0219c3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3160347332514456b2d9c39525d4acb3"
02:11:53.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.891211 13942 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate fc8e74ddac984cadaadc2bfcaf37a026 in term 1.
02:11:53.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.893314 13841 leader_election.cc:304] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [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: 3160347332514456b2d9c39525d4acb3, fc8e74ddac984cadaadc2bfcaf37a026; no voters: 
02:11:53.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.894385 14021 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "214004c65d664b44800d9e3bbe0219c3"
02:11:53.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.894750 13995 outbound_call.cc:321] RPC callback for RPC call kudu.consensus.ConsensusService.RequestConsensusVote -> {remote=127.13.124.190:42891, user_credentials={real_user=slave}} blocked reactor thread for 47318us
02:11:53.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.895735 14021 raft_consensus.cc:2393] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 1 FOLLOWER]: Leader election vote request: Denying vote to candidate fc8e74ddac984cadaadc2bfcaf37a026 in current term 1: Already voted for candidate 214004c65d664b44800d9e3bbe0219c3 in this term.
02:11:53.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.896333 13865 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "214004c65d664b44800d9e3bbe0219c3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "fc8e74ddac984cadaadc2bfcaf37a026"
02:11:53.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.897169 13865 raft_consensus.cc:2393] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 1 FOLLOWER]: Leader election vote request: Denying vote to candidate 214004c65d664b44800d9e3bbe0219c3 in current term 1: Already voted for candidate fc8e74ddac984cadaadc2bfcaf37a026 in this term.
02:11:53.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.897920 14067 leader_election.cc:290] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [CANDIDATE]: Term 1 election: Requested vote from peers fc8e74ddac984cadaadc2bfcaf37a026 (127.13.124.190:42891), 3160347332514456b2d9c39525d4acb3 (127.13.124.189:36301)
02:11:53.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.899304 13995 leader_election.cc:304] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [CANDIDATE]: Term 1 election: Election decided. Result: candidate lost. Election summary: received 3 responses out of 3 voters: 1 yes votes; 2 no votes. yes voters: 214004c65d664b44800d9e3bbe0219c3; no voters: 3160347332514456b2d9c39525d4acb3, fc8e74ddac984cadaadc2bfcaf37a026
02:11:53.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.903137 14096 raft_consensus.cc:2804] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 1 FOLLOWER]: Leader election won for term 1
02:11:53.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.904279 14067 raft_consensus.cc:2749] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 1 FOLLOWER]: Leader election lost for term 1. Reason: could not achieve majority
02:11:53.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.905160 14054 leader_election.cc:290] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [CANDIDATE]: Term 1 election: Requested vote from peers 3160347332514456b2d9c39525d4acb3 (127.13.124.189:36301), 214004c65d664b44800d9e3bbe0219c3 (127.13.124.188:43145)
02:11:53.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.919209 14096 raft_consensus.cc:697] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [term 1 LEADER]: Becoming Leader. State: Replica: fc8e74ddac984cadaadc2bfcaf37a026, State: Running, Role: LEADER
02:11:53.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.920282 14096 consensus_queue.cc:237] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [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: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } }
02:11:53.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.929128 14054 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [sys.catalog]: SysCatalogTable state changed. Reason: New leader fc8e74ddac984cadaadc2bfcaf37a026. Latest consensus state: current_term: 1 leader_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } } }
02:11:53.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.929873 14054 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [sys.catalog]: This master's current role is: LEADER
02:11:53.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.931463 14099 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
02:11:53.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.938511 14099 catalog_manager.cc:1519] Initializing Kudu cluster ID...
02:11:53.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.955322 14021 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [term 1 FOLLOWER]: Refusing update from remote peer fc8e74ddac984cadaadc2bfcaf37a026: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:11:53.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.955961 13942 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [term 1 FOLLOWER]: Refusing update from remote peer fc8e74ddac984cadaadc2bfcaf37a026: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:11:53.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.957655 14054 consensus_queue.cc:1048] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [LEADER]: Connected to new peer: Peer: permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:11:53.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:53.960741 13921 tablet.cc:2406] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:11:53.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:53.966773 14054 consensus_queue.cc:1048] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [LEADER]: Connected to new peer: Peer: permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:11:54.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.001966 14067 sys_catalog.cc:455] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [sys.catalog]: SysCatalogTable state changed. Reason: New leader fc8e74ddac984cadaadc2bfcaf37a026. Latest consensus state: current_term: 1 leader_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } } }
02:11:54.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.002789 14067 sys_catalog.cc:458] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [sys.catalog]: This master's current role is: FOLLOWER
02:11:54.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.008292 14100 mvcc.cc:204] Tried to move back new op lower bound from 7305120620343349248 to 7305120620228014080. Current Snapshot: MvccSnapshot[applied={T|T < 7305120620343349248}]
02:11:54.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.017241 14067 sys_catalog.cc:455] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } } }
02:11:54.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.018461 14067 sys_catalog.cc:458] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3 [sys.catalog]: This master's current role is: FOLLOWER
02:11:54.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.020087 14102 mvcc.cc:204] Tried to move back new op lower bound from 7305120620343349248 to 7305120620228014080. Current Snapshot: MvccSnapshot[applied={T|T < 7305120620343349248 or (T in {7305120620343349248})}]
02:11:54.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.020138 14097 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } } }
02:11:54.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.020970 14097 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [sys.catalog]: This master's current role is: LEADER
02:11:54.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.023032 14099 catalog_manager.cc:1382] Generated new cluster ID: d98b75399be44e8b8af173748d7d4ca8
02:11:54.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.023355 14099 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
02:11:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.030752 14083 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [sys.catalog]: SysCatalogTable state changed. Reason: New leader fc8e74ddac984cadaadc2bfcaf37a026. Latest consensus state: current_term: 1 leader_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } } }
02:11:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.036445 14083 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [sys.catalog]: This master's current role is: FOLLOWER
02:11:54.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.039633 14097 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } } }
02:11:54.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.040441 14097 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026 [sys.catalog]: This master's current role is: LEADER
02:11:54.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.053753 14083 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc8e74ddac984cadaadc2bfcaf37a026" member_type: VOTER last_known_addr { host: "127.13.124.190" port: 42891 } } peers { permanent_uuid: "3160347332514456b2d9c39525d4acb3" member_type: VOTER last_known_addr { host: "127.13.124.189" port: 36301 } } peers { permanent_uuid: "214004c65d664b44800d9e3bbe0219c3" member_type: VOTER last_known_addr { host: "127.13.124.188" port: 43145 } } }
02:11:54.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.055217 14083 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3 [sys.catalog]: This master's current role is: FOLLOWER
02:11:54.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.082244 14099 catalog_manager.cc:1405] Generated new certificate authority record
02:11:54.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.085291 14099 catalog_manager.cc:1539] Loading token signing keys...
02:11:54.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.118637 14099 catalog_manager.cc:6069] T 00000000000000000000000000000000 P fc8e74ddac984cadaadc2bfcaf37a026: Generated new TSK 0
02:11:54.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.120500 14099 catalog_manager.cc:1549] Initializing in-progress tserver states...
02:11:54.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.164961 13810 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:11:54.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:11:54.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/wal
02:11:54.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/data
02:11:54.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:11:54.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:11:54.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:11:54.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:54.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:54.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:54.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/logs
02:11:54.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/data/info.pb
02:11:54.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.129:0
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.124.129
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.129
02:11:54.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:54.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:11:54.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:11:54.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:54.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:54.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:11:54.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.568434 14079 catalog_manager.cc:1294] Loaded cluster ID: d98b75399be44e8b8af173748d7d4ca8
02:11:54.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.569283 14079 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3: loading cluster ID for follower catalog manager: success
02:11:54.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.577767 14079 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3: acquiring CA information for follower catalog manager: success
02:11:54.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.584714 14079 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 214004c65d664b44800d9e3bbe0219c3: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
02:11:54.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:54.719228 14108 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:11:54.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:54.719955 14108 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:11:54.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:54.720707 14108 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:11:54.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:54.782230 14108 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:11:54.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:54.784200 14108 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.124.129
02:11:54.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.827407 14094 catalog_manager.cc:1294] Loaded cluster ID: d98b75399be44e8b8af173748d7d4ca8
02:11:54.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.828264 14094 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3: loading cluster ID for follower catalog manager: success
02:11:54.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.836406 14094 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3: acquiring CA information for follower catalog manager: success
02:11:54.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.852176 14094 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 3160347332514456b2d9c39525d4acb3: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
02:11:54.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.878461 14108 tablet_server_runner.cc:78] Tablet server non-default flags:
02:11:54.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:54.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:11:54.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:54.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:54.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/data
02:11:54.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/wal
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.129:0
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/data/info.pb
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.129
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:11:54.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.124.129
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/logs
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on e7f111948823
02:11:54.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16850
02:11:54.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:11:54.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.888166 14108 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:11:54.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:54.891239 14108 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:11:54.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:54.935415 14115 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
02:11:57.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:56.327919 14114 debug-util.cc:398] Leaking SignalData structure 0x7b0800028000 after lost signal to thread 14108
02:11:57.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:54.942433 14116 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
02:11:57.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:57.301470 14114 kernel_stack_watchdog.cc:198] Thread 14108 stuck at /home/jenkins-slave/workspace/build_and_test@2/src/kudu/util/thread.cc:642 for 384ms:
02:11:57.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
02:11:57.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
02:11:57.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
02:11:57.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
02:11:57.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:57.302703 14108 thread.cc:641] GCE (cloud detector) Time spent creating pthread: real 2.362s	user 0.757s	sys 1.228s
02:11:57.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:57.303247 14108 thread.cc:608] GCE (cloud detector) Time spent starting thread: real 2.363s	user 0.757s	sys 1.228s
02:11:57.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:57.313319 14122 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
02:11:57.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.315917 14108 server_base.cc:1061] running on GCE node
02:11:57.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.317431 14108 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:11:57.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.320438 14108 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:11:57.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.322099 14108 hybrid_clock.cc:648] HybridClock initialized: now 1783476717322092 us; error 123 us; skew 500 ppm
02:11:57.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.323144 14108 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:11:57.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.330371 14108 webserver.cc:534] Webserver started at http://127.13.124.129:35969/ using document root <none> and password file <none>
02:11:57.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.331926 14108 fs_manager.cc:362] Metadata directory not provided
02:11:57.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.332309 14108 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:11:57.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.333014 14108 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:11:57.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.338052 14108 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/data/instance:
02:11:57.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a0157ca077704b8783876eea49f8f732"
02:11:57.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:57 on dist-test-slave-tzf0"
02:11:57.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.339617 14108 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/wal/instance:
02:11:57.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a0157ca077704b8783876eea49f8f732"
02:11:57.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:57 on dist-test-slave-tzf0"
02:11:57.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.349238 14108 fs_manager.cc:696] Time spent creating directory manager: real 0.009s	user 0.009s	sys 0.001s
02:11:57.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.359732 14127 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:11:57.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.361733 14108 fs_manager.cc:730] Time spent opening block manager: real 0.008s	user 0.005s	sys 0.001s
02:11:57.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.362152 14108 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/data,/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/wal
02:11:57.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a0157ca077704b8783876eea49f8f732"
02:11:57.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:57 on dist-test-slave-tzf0"
02:11:57.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.362627 14108 fs_report.cc:389] FS layout report
02:11:57.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:11:57.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/wal
02:11:57.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/wal
02:11:57.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/data/data
02:11:57.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:11:57.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:11:57.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:11:57.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:11:57.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:11:57.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:11:57.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:11:57.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:11:57.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:11:57.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:11:57.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:11:57.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.428414 14108 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:11:57.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.430451 14108 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:11:57.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.431087 14108 kserver.cc:163] Server-wide thread pool size limit: 3276
02:11:57.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.434607 14108 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:11:57.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.440580 14108 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:11:57.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.440892 14108 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:11:57.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.441202 14108 ts_tablet_manager.cc:616] Registered 0 tablets
02:11:57.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.441413 14108 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:11:57.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.633246 14108 rpc_server.cc:307] RPC server started. Bound to: 127.13.124.129:46229
02:11:57.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.633422 14239 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.124.129:46229 every 8 connection(s)
02:11:57.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.636224 14108 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/data/info.pb
02:11:57.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.642095 13810 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu as pid 14108
02:11:57.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.642783 13810 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-0/wal/instance
02:11:57.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.654686 13810 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:11:57.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:11:57.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/wal
02:11:57.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/data
02:11:57.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:11:57.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/logs
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/data/info.pb
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:57.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:11:57.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:11:57.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.130:0
02:11:57.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.124.130
02:11:57.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.130
02:11:57.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:57.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:11:57.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:11:57.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:57.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:57.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:11:57.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.705027 14240 heartbeater.cc:344] Connected to a master server at 127.13.124.188:43145
02:11:57.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.708652 14241 heartbeater.cc:344] Connected to a master server at 127.13.124.189:36301
02:11:57.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.708606 14240 heartbeater.cc:461] Registering TS with master...
02:11:57.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.710913 14240 heartbeater.cc:507] Master 127.13.124.188:43145 requested a full tablet report, sending...
02:11:57.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.709244 14241 heartbeater.cc:461] Registering TS with master...
02:11:57.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.713022 14241 heartbeater.cc:507] Master 127.13.124.189:36301 requested a full tablet report, sending...
02:11:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.715480 14247 heartbeater.cc:344] Connected to a master server at 127.13.124.190:42891
02:11:57.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.715842 14247 heartbeater.cc:461] Registering TS with master...
02:11:57.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.716058 14010 ts_manager.cc:194] Registered new tserver with Master: a0157ca077704b8783876eea49f8f732 (127.13.124.129:46229)
02:11:57.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.716794 14247 heartbeater.cc:507] Master 127.13.124.190:42891 requested a full tablet report, sending...
02:11:57.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.720317 13855 ts_manager.cc:194] Registered new tserver with Master: a0157ca077704b8783876eea49f8f732 (127.13.124.129:46229)
02:11:57.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.724725 13932 ts_manager.cc:194] Registered new tserver with Master: a0157ca077704b8783876eea49f8f732 (127.13.124.129:46229)
02:11:57.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:57.728585 13855 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.124.129:53383
02:11:58.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:58.042382 14245 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:11:58.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:58.043058 14245 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:11:58.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:58.043689 14245 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:11:58.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:58.080788 14245 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:11:58.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:58.081959 14245 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.124.130
02:11:58.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:58.120024 14245 tablet_server_runner.cc:78] Tablet server non-default flags:
02:11:58.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:58.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/data
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/wal
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.130:0
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/data/info.pb
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.130
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.124.130
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/logs
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on e7f111948823
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16850
02:11:58.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:11:58.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:58.121865 14245 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:11:58.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:58.123953 14245 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:11:58.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:58.139207 14256 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
02:11:58.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:58.732342 14247 heartbeater.cc:499] Master 127.13.124.190:42891 was elected leader, sending a full tablet report...
02:11:59.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:59.542372 14255 debug-util.cc:398] Leaking SignalData structure 0x7b0800028000 after lost signal to thread 14245
02:11:59.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:59.980007 14255 kernel_stack_watchdog.cc:198] Thread 14245 stuck at /home/jenkins-slave/workspace/build_and_test@2/src/kudu/util/thread.cc:642 for 398ms:
02:11:59.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
02:11:59.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
02:11:59.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
02:11:59.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
02:11:59.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:58.139463 14257 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
02:11:59.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:59.981457 14245 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.841s	user 0.647s	sys 1.061s
02:11:59.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:59.981841 14245 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.842s	user 0.647s	sys 1.061s
02:11:59.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:59.983652 14260 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
02:11:59.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:59.985845 14258 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1840 milliseconds
02:11:59.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:59.985853 14245 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
02:11:59.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:59.987244 14245 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:11:59.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:59.989365 14245 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:11:59.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:59.990756 14245 hybrid_clock.cc:648] HybridClock initialized: now 1783476719990728 us; error 42 us; skew 500 ppm
02:11:59.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:59.991641 14245 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:11:59.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:59.998307 14245 webserver.cc:534] Webserver started at http://127.13.124.130:39789/ using document root <none> and password file <none>
02:11:59.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:59.999482 14245 fs_manager.cc:362] Metadata directory not provided
02:11:59.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:59.999747 14245 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:12:00.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.000291 14245 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:12:00.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.005505 14245 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/data/instance:
02:12:00.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1fc49f92e7cd40c7a058c7b80467764d"
02:12:00.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:59 on dist-test-slave-tzf0"
02:12:00.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.009928 14245 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/wal/instance:
02:12:00.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1fc49f92e7cd40c7a058c7b80467764d"
02:12:00.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:59 on dist-test-slave-tzf0"
02:12:00.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.018877 14245 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.006s	sys 0.001s
02:12:00.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.025281 14267 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:12:00.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.026551 14245 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.007s	sys 0.000s
02:12:00.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.026974 14245 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/data,/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/wal
02:12:00.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1fc49f92e7cd40c7a058c7b80467764d"
02:12:00.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:59 on dist-test-slave-tzf0"
02:12:00.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.027438 14245 fs_report.cc:389] FS layout report
02:12:00.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:12:00.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/wal
02:12:00.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/wal
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/data/data
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:12:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:12:00.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.079669 14245 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:12:00.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.081423 14245 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:12:00.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.081967 14245 kserver.cc:163] Server-wide thread pool size limit: 3276
02:12:00.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.084815 14245 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:12:00.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.089174 14245 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:12:00.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.089468 14245 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:12:00.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.089767 14245 ts_tablet_manager.cc:616] Registered 0 tablets
02:12:00.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.090031 14245 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:12:00.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.244051 14245 rpc_server.cc:307] RPC server started. Bound to: 127.13.124.130:45541
02:12:00.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.244189 14379 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.124.130:45541 every 8 connection(s)
02:12:00.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.247186 14245 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/data/info.pb
02:12:00.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.248728 13810 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu as pid 14245
02:12:00.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.249212 13810 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-1/wal/instance
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.271432 13810 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/wal
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/data
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/logs
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/data/info.pb
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:12:00.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.131:0
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.124.131
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.131
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:12:00.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:12:00.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:12:00.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:12:00.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:12:00.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:12:00.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.316955 14382 heartbeater.cc:344] Connected to a master server at 127.13.124.190:42891
02:12:00.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.317487 14382 heartbeater.cc:461] Registering TS with master...
02:12:00.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.318728 14380 heartbeater.cc:344] Connected to a master server at 127.13.124.188:43145
02:12:00.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.319078 14380 heartbeater.cc:461] Registering TS with master...
02:12:00.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.320704 14382 heartbeater.cc:507] Master 127.13.124.190:42891 requested a full tablet report, sending...
02:12:00.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.320721 14380 heartbeater.cc:507] Master 127.13.124.188:43145 requested a full tablet report, sending...
02:12:00.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.324316 14010 ts_manager.cc:194] Registered new tserver with Master: 1fc49f92e7cd40c7a058c7b80467764d (127.13.124.130:45541)
02:12:00.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.325698 13855 ts_manager.cc:194] Registered new tserver with Master: 1fc49f92e7cd40c7a058c7b80467764d (127.13.124.130:45541)
02:12:00.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.326650 14381 heartbeater.cc:344] Connected to a master server at 127.13.124.189:36301
02:12:00.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.326995 14381 heartbeater.cc:461] Registering TS with master...
02:12:00.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.327414 13855 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.124.130:58069
02:12:00.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.327858 14381 heartbeater.cc:507] Master 127.13.124.189:36301 requested a full tablet report, sending...
02:12:00.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.331137 13932 ts_manager.cc:194] Registered new tserver with Master: 1fc49f92e7cd40c7a058c7b80467764d (127.13.124.130:45541)
02:12:00.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:00.648172 14389 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:12:00.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:00.648766 14389 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:12:00.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:00.649390 14389 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:12:00.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:00.683686 14389 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:12:00.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:00.684717 14389 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.124.131
02:12:00.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.722993 14389 tablet_server_runner.cc:78] Tablet server non-default flags:
02:12:00.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:12:00.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.124.148:40161
02:12:00.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:12:00.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:12:00.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/data
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/wal
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.124.131:0
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/data/info.pb
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.124.131
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.124.190:42891,127.13.124.189:36301,127.13.124.188:43145
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.124.131
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/logs
02:12:00.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:12:00.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:12:00.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:12:00.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:12:00.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:12:00.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:12:00.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:12:00.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on e7f111948823
02:12:00.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16850
02:12:00.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:12:00.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.724876 14389 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:12:00.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:00.726821 14389 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:12:00.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:00.740837 14396 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
02:12:01.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:01.331269 14382 heartbeater.cc:499] Master 127.13.124.190:42891 was elected leader, sending a full tablet report...
02:12:02.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:02.144248 14395 debug-util.cc:398] Leaking SignalData structure 0x7b0800028000 after lost signal to thread 14389
02:12:02.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:02.546738 14389 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.806s	user 0.561s	sys 1.193s
02:12:02.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:02.547164 14389 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.806s	user 0.561s	sys 1.193s
02:12:02.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:00.742237 14397 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
02:12:02.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:02.547818 14398 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1805 milliseconds
02:12:02.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:02.549171 14399 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
02:12:02.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.549082 14389 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
02:12:02.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.552649 14389 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:12:02.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.554935 14389 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:12:02.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.556329 14389 hybrid_clock.cc:648] HybridClock initialized: now 1783476722556249 us; error 94 us; skew 500 ppm
02:12:02.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.557245 14389 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:12:02.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.564123 14389 webserver.cc:534] Webserver started at http://127.13.124.131:42507/ using document root <none> and password file <none>
02:12:02.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.565328 14389 fs_manager.cc:362] Metadata directory not provided
02:12:02.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.565623 14389 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:12:02.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.566226 14389 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:12:02.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.571220 14389 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/data/instance:
02:12:02.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "42f0fbd6a5924fed9241db54ab48561c"
02:12:02.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:12:02 on dist-test-slave-tzf0"
02:12:02.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.572728 14389 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/wal/instance:
02:12:02.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "42f0fbd6a5924fed9241db54ab48561c"
02:12:02.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:12:02 on dist-test-slave-tzf0"
02:12:02.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.581096 14389 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.006s	sys 0.003s
02:12:02.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.587500 14407 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:12:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.588750 14389 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.002s
02:12:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.589118 14389 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/data,/tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/wal
02:12:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "42f0fbd6a5924fed9241db54ab48561c"
02:12:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:12:02 on dist-test-slave-tzf0"
02:12:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.589432 14389 fs_report.cc:389] FS layout report
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/wal
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/wal
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/data/data
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:12:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:12:02.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.662536 14389 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:12:02.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.664110 14389 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:12:02.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.664528 14389 kserver.cc:163] Server-wide thread pool size limit: 3276
02:12:02.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.667332 14389 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:12:02.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.671609 14389 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:12:02.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.671820 14389 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:12:02.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.672016 14389 ts_tablet_manager.cc:616] Registered 0 tablets
02:12:02.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.672140 14389 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:12:02.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.825750 14389 rpc_server.cc:307] RPC server started. Bound to: 127.13.124.131:43867
02:12:02.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.825858 14520 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.124.131:43867 every 8 connection(s)
02:12:02.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.828594 14389 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/data/info.pb
02:12:02.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.838092 13810 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu as pid 14389
02:12:02.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.838603 13810 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskU3NM2m/test-tmp/mini-kudu-cluster16463608212890266588/ts-2/wal/instance
02:12:02.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.881026 14522 heartbeater.cc:344] Connected to a master server at 127.13.124.189:36301
02:12:02.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.881126 14521 heartbeater.cc:344] Connected to a master server at 127.13.124.188:43145
02:12:02.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.881646 14522 heartbeater.cc:461] Registering TS with master...
02:12:02.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.881986 14521 heartbeater.cc:461] Registering TS with master...
02:12:02.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.883220 14521 heartbeater.cc:507] Master 127.13.124.188:43145 requested a full tablet report, sending...
02:12:02.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.883272 14522 heartbeater.cc:507] Master 127.13.124.189:36301 requested a full tablet report, sending...
02:12:02.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.887086 14523 heartbeater.cc:344] Connected to a master server at 127.13.124.190:42891
02:12:02.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.887430 13931 ts_manager.cc:194] Registered new tserver with Master: 42f0fbd6a5924fed9241db54ab48561c (127.13.124.131:43867)
02:12:02.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.887842 14523 heartbeater.cc:461] Registering TS with master...
02:12:02.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.888904 14523 heartbeater.cc:507] Master 127.13.124.190:42891 requested a full tablet report, sending...
02:12:02.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.889518 14010 ts_manager.cc:194] Registered new tserver with Master: 42f0fbd6a5924fed9241db54ab48561c (127.13.124.131:43867)
02:12:02.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.891450 13855 ts_manager.cc:194] Registered new tserver with Master: 42f0fbd6a5924fed9241db54ab48561c (127.13.124.131:43867)
02:12:02.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.893225 13855 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.124.131:43165
02:12:02.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:02.897969 13810 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
02:12:02.910 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
02:12:02.911 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

02:12:02.921 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.124.190"
      port: 42891
    }
    bound_http_address {
      host: "127.13.124.190"
      port: 43469
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.13.124.189"
      port: 36301
    }
    bound_http_address {
      host: "127.13.124.189"
      port: 44141
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.13.124.188"
      port: 43145
    }
    bound_http_address {
      host: "127.13.124.188"
      port: 39413
    }
  }
}

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

02:12:02.927 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.124.129"
      port: 46229
    }
    bound_http_address {
      host: "127.13.124.129"
      port: 35969
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.13.124.130"
      port: 45541
    }
    bound_http_address {
      host: "127.13.124.130"
      port: 39789
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.13.124.131"
      port: 43867
    }
    bound_http_address {
      host: "127.13.124.131"
      port: 42507
    }
  }
}

02:12:02.927 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
02:12:03.113 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
02:12:03.168 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
02:12:03.333 [DEBUG - main] (Connection.java:748) [peer master-127.13.124.188:43145(127.13.124.188:43145)] connecting to peer
02:12:03.397 [DEBUG - main] (Connection.java:748) [peer master-127.13.124.189:36301(127.13.124.189:36301)] connecting to peer
02:12:03.399 [DEBUG - main] (Connection.java:748) [peer master-127.13.124.190:42891(127.13.124.190:42891)] connecting to peer
02:12:03.418 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.13.124.189:36301(127.13.124.189:36301)] Successfully connected to peer
02:12:03.419 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.13.124.188:43145(127.13.124.188:43145)] Successfully connected to peer
02:12:03.422 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.13.124.190:42891(127.13.124.190:42891)] Successfully connected to peer
02:12:03.519 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.124.190
02:12:03.519 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.124.189
02:12:03.520 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.124.188
02:12:03.754 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xd8b339c4, L:/127.0.0.1:52574 - R:/127.13.124.189:36301] using SASL/PLAIN
02:12:03.755 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x69fd74d0, L:/127.0.0.1:38180 - R:/127.13.124.188:43145] using SASL/PLAIN
02:12:03.755 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x07f99b62, L:/127.0.0.1:33160 - R:/127.13.124.190:42891] using SASL/PLAIN
02:12:03.794 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
02:12:03.796 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=506), Traces: [0ms] refreshing cache from master, [29ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.124.188:43145, [103ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.124.189:36301, [104ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.124.190:42891, [476ms] Sub RPC ConnectToMaster: received response from server master-127.13.124.188:43145: OK, [476ms] Sub RPC ConnectToMaster: received response from server master-127.13.124.189:36301: OK, [477ms] Sub RPC ConnectToMaster: received response from server master-127.13.124.190:42891: OK, deferred=null) after lookup
02:12:03.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:03.852517 13855 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:33160:
02:12:03.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783476706121"
02:12:03.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
02:12:03.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
02:12:03.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
02:12:03.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
02:12:03.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:03.855867 13855 catalog_manager.cc:7076] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1783476706121 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
02:12:03.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:03.897414 14523 heartbeater.cc:499] Master 127.13.124.190:42891 was elected leader, sending a full tablet report...
02:12:03.927 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:894) Opened table 059fea4ace4f4271befbdd26ba062d8a
02:12:03.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:03.953229 14175 tablet_service.cc:1511] Processing CreateTablet for tablet bc4e25635ad945dbb7366980f9bd0a2b (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476706121 [id=059fea4ace4f4271befbdd26ba062d8a]), partition=RANGE (key) PARTITION UNBOUNDED
02:12:03.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:03.955853 14175 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet bc4e25635ad945dbb7366980f9bd0a2b. 1 dirs total, 0 dirs full, 0 dirs failed
02:12:03.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:03.968271 14455 tablet_service.cc:1511] Processing CreateTablet for tablet bc4e25635ad945dbb7366980f9bd0a2b (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476706121 [id=059fea4ace4f4271befbdd26ba062d8a]), partition=RANGE (key) PARTITION UNBOUNDED
02:12:03.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:03.970124 14455 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet bc4e25635ad945dbb7366980f9bd0a2b. 1 dirs total, 0 dirs full, 0 dirs failed
02:12:03.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:03.972743 14315 tablet_service.cc:1511] Processing CreateTablet for tablet bc4e25635ad945dbb7366980f9bd0a2b (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476706121 [id=059fea4ace4f4271befbdd26ba062d8a]), partition=RANGE (key) PARTITION UNBOUNDED
02:12:03.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:03.975221 14315 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet bc4e25635ad945dbb7366980f9bd0a2b. 1 dirs total, 0 dirs full, 0 dirs failed
02:12:03.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:03.989374 14555 tablet_bootstrap.cc:492] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732: Bootstrap starting.
02:12:04.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:03.999212 14555 tablet_bootstrap.cc:654] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732: Neither blocks nor log segments found. Creating new log.
02:12:04.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.002231 14556 tablet_bootstrap.cc:492] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d: Bootstrap starting.
02:12:04.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.002854 14555 log.cc:826] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732: Log is configured to *not* fsync() on all Append() calls
02:12:04.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.005551 14557 tablet_bootstrap.cc:492] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c: Bootstrap starting.
02:12:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.009363 14555 tablet_bootstrap.cc:492] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732: No bootstrap required, opened a new log
02:12:04.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.009924 14555 ts_tablet_manager.cc:1403] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732: Time spent bootstrapping tablet: real 0.022s	user 0.011s	sys 0.004s
02:12:04.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.011797 14556 tablet_bootstrap.cc:654] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d: Neither blocks nor log segments found. Creating new log.
02:12:04.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.014424 14556 log.cc:826] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d: Log is configured to *not* fsync() on all Append() calls
02:12:04.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.015710 14557 tablet_bootstrap.cc:654] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c: Neither blocks nor log segments found. Creating new log.
02:12:04.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.018389 14557 log.cc:826] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c: Log is configured to *not* fsync() on all Append() calls
02:12:04.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.020670 14556 tablet_bootstrap.cc:492] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d: No bootstrap required, opened a new log
02:12:04.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.021436 14556 ts_tablet_manager.cc:1403] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d: Time spent bootstrapping tablet: real 0.020s	user 0.016s	sys 0.000s
02:12:04.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.025722 14557 tablet_bootstrap.cc:492] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c: No bootstrap required, opened a new log
02:12:04.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.026876 14557 ts_tablet_manager.cc:1403] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c: Time spent bootstrapping tablet: real 0.022s	user 0.010s	sys 0.007s
02:12:04.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.039207 14555 raft_consensus.cc:359] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a0157ca077704b8783876eea49f8f732" member_type: VOTER last_known_addr { host: "127.13.124.129" port: 46229 } } peers { permanent_uuid: "1fc49f92e7cd40c7a058c7b80467764d" member_type: VOTER last_known_addr { host: "127.13.124.130" port: 45541 } } peers { permanent_uuid: "42f0fbd6a5924fed9241db54ab48561c" member_type: VOTER last_known_addr { host: "127.13.124.131" port: 43867 } }
02:12:04.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.040145 14555 raft_consensus.cc:385] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:12:04.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.040442 14555 raft_consensus.cc:740] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: a0157ca077704b8783876eea49f8f732, State: Initialized, Role: FOLLOWER
02:12:04.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.041484 14555 consensus_queue.cc:260] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732 [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: "a0157ca077704b8783876eea49f8f732" member_type: VOTER last_known_addr { host: "127.13.124.129" port: 46229 } } peers { permanent_uuid: "1fc49f92e7cd40c7a058c7b80467764d" member_type: VOTER last_known_addr { host: "127.13.124.130" port: 45541 } } peers { permanent_uuid: "42f0fbd6a5924fed9241db54ab48561c" member_type: VOTER last_known_addr { host: "127.13.124.131" port: 43867 } }
02:12:04.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.045444 14555 ts_tablet_manager.cc:1434] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732: Time spent starting tablet: real 0.035s	user 0.020s	sys 0.016s
02:12:04.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.056382 14556 raft_consensus.cc:359] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a0157ca077704b8783876eea49f8f732" member_type: VOTER last_known_addr { host: "127.13.124.129" port: 46229 } } peers { permanent_uuid: "1fc49f92e7cd40c7a058c7b80467764d" member_type: VOTER last_known_addr { host: "127.13.124.130" port: 45541 } } peers { permanent_uuid: "42f0fbd6a5924fed9241db54ab48561c" member_type: VOTER last_known_addr { host: "127.13.124.131" port: 43867 } }
02:12:04.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.057749 14556 raft_consensus.cc:385] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:12:04.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.058404 14556 raft_consensus.cc:740] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 1fc49f92e7cd40c7a058c7b80467764d, State: Initialized, Role: FOLLOWER
02:12:04.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.059952 14556 consensus_queue.cc:260] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [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: "a0157ca077704b8783876eea49f8f732" member_type: VOTER last_known_addr { host: "127.13.124.129" port: 46229 } } peers { permanent_uuid: "1fc49f92e7cd40c7a058c7b80467764d" member_type: VOTER last_known_addr { host: "127.13.124.130" port: 45541 } } peers { permanent_uuid: "42f0fbd6a5924fed9241db54ab48561c" member_type: VOTER last_known_addr { host: "127.13.124.131" port: 43867 } }
02:12:04.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.064013 14556 ts_tablet_manager.cc:1434] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d: Time spent starting tablet: real 0.042s	user 0.028s	sys 0.008s
02:12:04.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.068756 14557 raft_consensus.cc:359] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a0157ca077704b8783876eea49f8f732" member_type: VOTER last_known_addr { host: "127.13.124.129" port: 46229 } } peers { permanent_uuid: "1fc49f92e7cd40c7a058c7b80467764d" member_type: VOTER last_known_addr { host: "127.13.124.130" port: 45541 } } peers { permanent_uuid: "42f0fbd6a5924fed9241db54ab48561c" member_type: VOTER last_known_addr { host: "127.13.124.131" port: 43867 } }
02:12:04.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.069739 14557 raft_consensus.cc:385] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:12:04.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.070154 14557 raft_consensus.cc:740] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 42f0fbd6a5924fed9241db54ab48561c, State: Initialized, Role: FOLLOWER
02:12:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.071480 14557 consensus_queue.cc:260] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c [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: "a0157ca077704b8783876eea49f8f732" member_type: VOTER last_known_addr { host: "127.13.124.129" port: 46229 } } peers { permanent_uuid: "1fc49f92e7cd40c7a058c7b80467764d" member_type: VOTER last_known_addr { host: "127.13.124.130" port: 45541 } } peers { permanent_uuid: "42f0fbd6a5924fed9241db54ab48561c" member_type: VOTER last_known_addr { host: "127.13.124.131" port: 43867 } }
02:12:04.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.084575 14557 ts_tablet_manager.cc:1434] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c: Time spent starting tablet: real 0.057s	user 0.030s	sys 0.005s
02:12:04.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:04.121918 14524 tablet.cc:2406] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:12:04.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:04.216985 14248 tablet.cc:2406] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:12:04.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.232388 14562 raft_consensus.cc:493] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:12:04.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.232901 14562 raft_consensus.cc:515] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a0157ca077704b8783876eea49f8f732" member_type: VOTER last_known_addr { host: "127.13.124.129" port: 46229 } } peers { permanent_uuid: "1fc49f92e7cd40c7a058c7b80467764d" member_type: VOTER last_known_addr { host: "127.13.124.130" port: 45541 } } peers { permanent_uuid: "42f0fbd6a5924fed9241db54ab48561c" member_type: VOTER last_known_addr { host: "127.13.124.131" port: 43867 } }
02:12:04.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.235934 14562 leader_election.cc:290] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers a0157ca077704b8783876eea49f8f732 (127.13.124.129:46229), 42f0fbd6a5924fed9241db54ab48561c (127.13.124.131:43867)
02:12:04.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.249260 14195 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "bc4e25635ad945dbb7366980f9bd0a2b" candidate_uuid: "1fc49f92e7cd40c7a058c7b80467764d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "a0157ca077704b8783876eea49f8f732" is_pre_election: true
02:12:04.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.249732 14475 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "bc4e25635ad945dbb7366980f9bd0a2b" candidate_uuid: "1fc49f92e7cd40c7a058c7b80467764d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "42f0fbd6a5924fed9241db54ab48561c" is_pre_election: true
02:12:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.250226 14195 raft_consensus.cc:2468] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 1fc49f92e7cd40c7a058c7b80467764d in term 0.
02:12:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.250636 14475 raft_consensus.cc:2468] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 1fc49f92e7cd40c7a058c7b80467764d in term 0.
02:12:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.252247 14269 leader_election.cc:304] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [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: 1fc49f92e7cd40c7a058c7b80467764d, a0157ca077704b8783876eea49f8f732; no voters: 
02:12:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.253206 14562 raft_consensus.cc:2804] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [term 0 FOLLOWER]: Leader pre-election won for term 1
02:12:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.253538 14562 raft_consensus.cc:493] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
02:12:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.253851 14562 raft_consensus.cc:3060] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [term 0 FOLLOWER]: Advancing to term 1
02:12:04.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.260619 14562 raft_consensus.cc:515] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a0157ca077704b8783876eea49f8f732" member_type: VOTER last_known_addr { host: "127.13.124.129" port: 46229 } } peers { permanent_uuid: "1fc49f92e7cd40c7a058c7b80467764d" member_type: VOTER last_known_addr { host: "127.13.124.130" port: 45541 } } peers { permanent_uuid: "42f0fbd6a5924fed9241db54ab48561c" member_type: VOTER last_known_addr { host: "127.13.124.131" port: 43867 } }
02:12:04.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.262579 14562 leader_election.cc:290] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [CANDIDATE]: Term 1 election: Requested vote from peers a0157ca077704b8783876eea49f8f732 (127.13.124.129:46229), 42f0fbd6a5924fed9241db54ab48561c (127.13.124.131:43867)
02:12:04.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.263379 14195 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "bc4e25635ad945dbb7366980f9bd0a2b" candidate_uuid: "1fc49f92e7cd40c7a058c7b80467764d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "a0157ca077704b8783876eea49f8f732"
02:12:04.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.263893 14475 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "bc4e25635ad945dbb7366980f9bd0a2b" candidate_uuid: "1fc49f92e7cd40c7a058c7b80467764d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "42f0fbd6a5924fed9241db54ab48561c"
02:12:04.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.263964 14195 raft_consensus.cc:3060] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732 [term 0 FOLLOWER]: Advancing to term 1
02:12:04.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.264453 14475 raft_consensus.cc:3060] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c [term 0 FOLLOWER]: Advancing to term 1
02:12:04.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.269614 14475 raft_consensus.cc:2468] T bc4e25635ad945dbb7366980f9bd0a2b P 42f0fbd6a5924fed9241db54ab48561c [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 1fc49f92e7cd40c7a058c7b80467764d in term 1.
02:12:04.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.270773 14195 raft_consensus.cc:2468] T bc4e25635ad945dbb7366980f9bd0a2b P a0157ca077704b8783876eea49f8f732 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 1fc49f92e7cd40c7a058c7b80467764d in term 1.
02:12:04.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.270851 14268 leader_election.cc:304] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [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: 1fc49f92e7cd40c7a058c7b80467764d, 42f0fbd6a5924fed9241db54ab48561c; no voters: 
02:12:04.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.271596 14562 raft_consensus.cc:2804] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [term 1 FOLLOWER]: Leader election won for term 1
02:12:04.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.273387 14562 raft_consensus.cc:697] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [term 1 LEADER]: Becoming Leader. State: Replica: 1fc49f92e7cd40c7a058c7b80467764d, State: Running, Role: LEADER
02:12:04.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.274302 14562 consensus_queue.cc:237] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [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: "a0157ca077704b8783876eea49f8f732" member_type: VOTER last_known_addr { host: "127.13.124.129" port: 46229 } } peers { permanent_uuid: "1fc49f92e7cd40c7a058c7b80467764d" member_type: VOTER last_known_addr { host: "127.13.124.130" port: 45541 } } peers { permanent_uuid: "42f0fbd6a5924fed9241db54ab48561c" member_type: VOTER last_known_addr { host: "127.13.124.131" port: 43867 } }
02:12:04.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:12:04.283798 14387 tablet.cc:2406] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:12:04.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.286211 13854 catalog_manager.cc:5696] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d reported cstate change: term changed from 0 to 1, leader changed from <none> to 1fc49f92e7cd40c7a058c7b80467764d (127.13.124.130). New cstate: current_term: 1 leader_uuid: "1fc49f92e7cd40c7a058c7b80467764d" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a0157ca077704b8783876eea49f8f732" member_type: VOTER last_known_addr { host: "127.13.124.129" port: 46229 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "1fc49f92e7cd40c7a058c7b80467764d" member_type: VOTER last_known_addr { host: "127.13.124.130" port: 45541 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "42f0fbd6a5924fed9241db54ab48561c" member_type: VOTER last_known_addr { host: "127.13.124.131" port: 43867 } health_report { overall_health: UNKNOWN } } }
02:12:04.634 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet bc4e25635ad945dbb7366980f9bd0a2b for table 'org.apache.kudu.client.TestHybridTime-1783476706121' with partition [<start>, <end>)
02:12:04.641 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=bc4e25635ad945dbb7366980f9bd0a2b@[1fc49f92e7cd40c7a058c7b80467764d(127.13.124.130:45541)[L],42f0fbd6a5924fed9241db54ab48561c(127.13.124.131:43867),a0157ca077704b8783876eea49f8f732(127.13.124.129:46229)]}]
02:12:04.643 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=20), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.13.124.190:42891, [9ms] Sub RPC GetTableLocations: received response from server master-127.13.124.190:42891: OK, deferred=null) after lookup
02:12:04.655 [DEBUG - kudu-nio-2] (Connection.java:748) [peer 1fc49f92e7cd40c7a058c7b80467764d(127.13.124.130:45541)] connecting to peer
02:12:04.658 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 1fc49f92e7cd40c7a058c7b80467764d(127.13.124.130:45541)] Successfully connected to peer
02:12:04.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.672163 14562 consensus_queue.cc:1048] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [LEADER]: Connected to new peer: Peer: permanent_uuid: "a0157ca077704b8783876eea49f8f732" member_type: VOTER last_known_addr { host: "127.13.124.129" port: 46229 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
02:12:04.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:04.742828 14566 consensus_queue.cc:1048] T bc4e25635ad945dbb7366980f9bd0a2b P 1fc49f92e7cd40c7a058c7b80467764d [LEADER]: Connected to new peer: Peer: permanent_uuid: "42f0fbd6a5924fed9241db54ab48561c" member_type: VOTER last_known_addr { host: "127.13.124.131" port: 43867 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:12:04.772 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x1f78a1a9, L:/127.0.0.1:42652 - R:/127.13.124.130:45541] using TOKEN/null
02:12:04.862 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:12:04.896 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:12:04.916 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:12:04.922 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1533335597(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:12:04.955 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:12:04.956 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1938880610(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:12:04.976 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:12:04.976 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1492949940(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:12:04.993 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:12:05.048 [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-1783476706121, tablet=bc4e25635ad945dbb7366980f9bd0a2b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:12:05.063 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305120685180129281) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476706121, tablet=bc4e25635ad945dbb7366980f9bd0a2b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:12:05.074 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305120685180129285) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476706121, tablet=bc4e25635ad945dbb7366980f9bd0a2b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:12:05.086 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305120685180129289) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476706121, tablet=bc4e25635ad945dbb7366980f9bd0a2b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:12:05.097 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305120685180129293) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476706121, tablet=bc4e25635ad945dbb7366980f9bd0a2b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:12:05.109 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305120685180129297) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476706121, tablet=bc4e25635ad945dbb7366980f9bd0a2b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:12:05.120 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305120685180129301) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476706121, tablet=bc4e25635ad945dbb7366980f9bd0a2b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:12:05.133 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305120685180129302) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476706121, tablet=bc4e25635ad945dbb7366980f9bd0a2b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:12:05.136 [DEBUG - main] (Connection.java:575) [peer master-127.13.124.189:36301(127.13.124.189:36301)] disconnecting while in state READY
02:12:05.138 [DEBUG - main] (Connection.java:575) [peer master-127.13.124.190:42891(127.13.124.190:42891)] disconnecting while in state READY
02:12:05.139 [DEBUG - main] (Connection.java:575) [peer 1fc49f92e7cd40c7a058c7b80467764d(127.13.124.130:45541)] disconnecting while in state READY
02:12:05.140 [DEBUG - main] (Connection.java:575) [peer master-127.13.124.188:43145(127.13.124.188:43145)] disconnecting while in state READY
02:12:05.145 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2704) Releasing all remaining resources
02:12:05.145 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.13.124.190:42891(127.13.124.190:42891)] handling channelInactive
02:12:05.146 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.13.124.190:42891(127.13.124.190:42891)] cleaning up while in state READY due to: connection closed
02:12:05.146 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 1fc49f92e7cd40c7a058c7b80467764d(127.13.124.130:45541)] handling channelInactive
02:12:05.146 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 1fc49f92e7cd40c7a058c7b80467764d(127.13.124.130:45541)] cleaning up while in state READY due to: connection closed
02:12:05.148 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.13.124.189:36301(127.13.124.189:36301)] handling channelInactive
02:12:05.148 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.13.124.189:36301(127.13.124.189:36301)] cleaning up while in state READY due to: connection closed
02:12:05.152 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.13.124.188:43145(127.13.124.188:43145)] handling channelInactive
02:12:05.152 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.13.124.188:43145(127.13.124.188:43145)] cleaning up while in state READY due to: connection closed
02:12:05.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:05.152285 13810 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu with pid 14108
02:12:05.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:05.180684 13810 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu with pid 14245
02:12:05.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:05.220997 13810 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu with pid 14389
02:12:05.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:05.252498 13810 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu with pid 13822
02:12:05.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:05.277064 13810 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu with pid 13892
02:12:05.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:12:05.304765 13810 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskU3NM2m/build/tsan/bin/kudu with pid 13969
02:12:06.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:12:06Z chronyd exiting

Time: 21.339

OK (1 test)

