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

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

20:03:57.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:57.859247 12296 mini_oidc.cc:150] Starting JWKS server
20:03:57.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:57.863468 12296 webserver.cc:533] Webserver started at http://127.0.0.1:36407/ using document root <none> and password file <none>
20:03:57.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:57.864075 12296 mini_oidc.cc:186] Starting OIDC Discovery server
20:03:57.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:57.866206 12296 webserver.cc:533] Webserver started at http://127.0.0.1:42585/ using document root <none> and password file <none>
20:03:57.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T20:03:57Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
20:03:57.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T20:03:57Z Disabled control of system clock
20:03:57.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:57.929557 12296 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:03:57.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:03:57.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/wal
20:03:57.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/data
20:03:57.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:57.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:57.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:57.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:57.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:57.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:57.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/logs
20:03:57.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/data/info.pb
20:03:57.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:57.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:57.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:57.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:57.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:57.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:57.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:57.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:57.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
20:03:57.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:57.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:03:57.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:03:57.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.62:43383
20:03:57.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.62
20:03:57.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:57.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:03:57.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:57.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:57.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:57.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:03:57.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:03:57.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:03:57.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36407/jwks.json with env {}
20:03:58.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:58.231252 12308 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:58.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:58.231963 12308 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:58.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:58.232720 12308 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:58.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:58.265872 12308 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
20:03:58.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:58.266250 12308 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:58.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:58.266556 12308 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
20:03:58.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:58.266898 12308 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
20:03:58.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:58.267241 12308 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
20:03:58.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:58.267506 12308 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36407/jwks.json
20:03:58.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:58.307016 12308 master_runner.cc:387] Master server non-default flags:
20:03:58.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:58.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:03:58.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:58.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:58.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/data
20:03:58.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/wal
20:03:58.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:03:58.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:03:58.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:58.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:58.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:03:58.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.62:43383
20:03:58.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:03:58.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:58.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:03:58.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36407/jwks.json
20:03:58.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:58.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:58.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/data/info.pb
20:03:58.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.62
20:03:58.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:58.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:58.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:58.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:58.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:58.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:58.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/logs
20:03:58.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:58.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:58.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:58.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
20:03:58.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:58.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
20:03:58.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:03:58.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 19:43:23 UTC on e7f111948823
20:03:58.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11963
20:03:58.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:03:58.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:58.308732 12308 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:58.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:58.311064 12308 file_cache.cc:492] Constructed file cache file cache with capacity 419430
20:03:58.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:58.324608 12314 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:03:59.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:58.326382 12315 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:03:59.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:59.536216 12317 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:03:59.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:59.538854 12316 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1208 milliseconds
20:03:59.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.538950 12308 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
20:03:59.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.540242 12308 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:59.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.542912 12308 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:59.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.544356 12308 hybrid_clock.cc:648] HybridClock initialized: now 1779134639544319 us; error 37 us; skew 500 ppm
20:03:59.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.545375 12308 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:03:59.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.552122 12308 webserver.cc:533] Webserver started at http://127.12.2.62:35163/ using document root <none> and password file <none>
20:03:59.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.553246 12308 fs_manager.cc:362] Metadata directory not provided
20:03:59.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.553498 12308 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:59.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.554136 12308 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:59.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.558745 12308 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/data/instance:
20:03:59.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dfd308518f0042e9b2ce90a3dbd16927"
20:03:59.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:03:59 on dist-test-slave-x560"
20:03:59.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.560161 12308 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/wal/instance:
20:03:59.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dfd308518f0042e9b2ce90a3dbd16927"
20:03:59.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:03:59 on dist-test-slave-x560"
20:03:59.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.567581 12308 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.009s	sys 0.000s
20:03:59.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.573413 12324 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:59.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.574591 12308 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.002s
20:03:59.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.574946 12308 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/data,/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/wal
20:03:59.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dfd308518f0042e9b2ce90a3dbd16927"
20:03:59.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:03:59 on dist-test-slave-x560"
20:03:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.575248 12308 fs_report.cc:389] FS layout report
20:03:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/wal
20:03:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/wal
20:03:59.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/data/data
20:03:59.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:59.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:59.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:59.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:59.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:59.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:59.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:59.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:59.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:59.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:59.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:59.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.639647 12308 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:59.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.641301 12308 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
20:03:59.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.641716 12308 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:59.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.714453 12308 rpc_server.cc:307] RPC server started. Bound to: 127.12.2.62:43383
20:03:59.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.714551 12375 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.2.62:43383 every 8 connection(s)
20:03:59.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.717480 12308 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/data/info.pb
20:03:59.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.723141 12376 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:59.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.724677 12296 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu as pid 12308
20:03:59.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.725134 12296 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-0/wal/instance
20:03:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.728643 12296 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:03:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:03:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/wal
20:03:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/data
20:03:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:59.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:59.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:59.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:59.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:59.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:59.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/logs
20:03:59.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/data/info.pb
20:03:59.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:59.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:59.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:59.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:59.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:59.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:59.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:59.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:59.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
20:03:59.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:59.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:03:59.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:03:59.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.61:45125
20:03:59.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.61
20:03:59.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:59.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:03:59.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:59.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:59.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:59.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:03:59.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:03:59.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:03:59.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36407/jwks.json with env {}
20:03:59.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.734660 12376 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } has no permanent_uuid. Determining permanent_uuid...
20:03:59.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.764984 12376 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } has no permanent_uuid. Determining permanent_uuid...
20:03:59.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:59.767767 12326 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.12.2.61:45125: connect: Connection refused (error 111)
20:03:59.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:59.772281 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.61:45125: Network error: Client connection negotiation failed: client connection to 127.12.2.61:45125: connect: Connection refused (error 111)
20:03:59.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.821784 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } attempt: 1
20:03:59.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:59.826642 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.61:45125: Network error: Client connection negotiation failed: client connection to 127.12.2.61:45125: connect: Connection refused (error 111)
20:03:59.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.895057 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } attempt: 2
20:03:59.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:59.899461 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.61:45125: Network error: Client connection negotiation failed: client connection to 127.12.2.61:45125: connect: Connection refused (error 111)
20:03:59.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:03:59.990883 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } attempt: 3
20:03:59.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:03:59.997188 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.61:45125: Network error: Client connection negotiation failed: client connection to 127.12.2.61:45125: connect: Connection refused (error 111)
20:04:00.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.043576 12378 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:04:00.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.044332 12378 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:04:00.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.045115 12378 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:04:00.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.079488 12378 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
20:04:00.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.079895 12378 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:04:00.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.080222 12378 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
20:04:00.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.080556 12378 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
20:04:00.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.080928 12378 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
20:04:00.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.081234 12378 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36407/jwks.json
20:04:00.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:00.119506 12378 master_runner.cc:387] Master server non-default flags:
20:04:00.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:04:00.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:04:00.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:04:00.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:04:00.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/data
20:04:00.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/wal
20:04:00.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:04:00.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:04:00.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:04:00.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:04:00.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:04:00.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.61:45125
20:04:00.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:04:00.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:04:00.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:04:00.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36407/jwks.json
20:04:00.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:04:00.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:04:00.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/data/info.pb
20:04:00.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.61
20:04:00.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:04:00.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:04:00.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:04:00.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:04:00.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:04:00.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:04:00.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/logs
20:04:00.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:04:00.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:04:00.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:04:00.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
20:04:00.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:04:00.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
20:04:00.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:04:00.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 19:43:23 UTC on e7f111948823
20:04:00.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11963
20:04:00.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:04:00.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:00.121323 12378 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:04:00.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:00.123752 12378 file_cache.cc:492] Constructed file cache file cache with capacity 419430
20:04:00.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.136724 12387 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:00.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:00.140576 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } attempt: 4
20:04:00.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.145538 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.61:45125: Network error: Client connection negotiation failed: client connection to 127.12.2.61:45125: connect: Connection refused (error 111)
20:04:00.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:00.444995 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } attempt: 5
20:04:00.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.450809 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.61:45125: Network error: Client connection negotiation failed: client connection to 127.12.2.61:45125: connect: Connection refused (error 111)
20:04:00.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:00.998273 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } attempt: 6
20:04:01.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.008219 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.61:45125: Network error: Client connection negotiation failed: client connection to 127.12.2.61:45125: connect: Connection refused (error 111)
20:04:01.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:00.138177 12388 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:01.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.348007 12389 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
20:04:01.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.349663 12390 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:01.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.349664 12378 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
20:04:01.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.353592 12378 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:04:01.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.356766 12378 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:04:01.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.360368 12378 hybrid_clock.cc:648] HybridClock initialized: now 1779134641359126 us; error 1233 us; skew 500 ppm
20:04:01.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.361438 12378 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:04:01.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.367605 12378 webserver.cc:533] Webserver started at http://127.12.2.61:35787/ using document root <none> and password file <none>
20:04:01.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.368675 12378 fs_manager.cc:362] Metadata directory not provided
20:04:01.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.369007 12378 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:04:01.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.369604 12378 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:04:01.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.376101 12378 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/data/instance:
20:04:01.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ea9341342a574258abbd9edcff0e40c5"
20:04:01.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:01 on dist-test-slave-x560"
20:04:01.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.377444 12378 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/wal/instance:
20:04:01.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ea9341342a574258abbd9edcff0e40c5"
20:04:01.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:01 on dist-test-slave-x560"
20:04:01.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.384719 12378 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.006s	sys 0.000s
20:04:01.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.390497 12399 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:04:01.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.391691 12378 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.002s
20:04:01.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.392073 12378 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/data,/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/wal
20:04:01.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ea9341342a574258abbd9edcff0e40c5"
20:04:01.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:01 on dist-test-slave-x560"
20:04:01.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.392521 12378 fs_report.cc:389] FS layout report
20:04:01.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:04:01.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/wal
20:04:01.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/wal
20:04:01.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/data/data
20:04:01.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:04:01.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:04:01.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:04:01.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:04:01.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:04:01.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:04:01.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:04:01.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:04:01.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:04:01.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:04:01.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:04:01.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.477450 12378 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:04:01.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.479020 12378 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
20:04:01.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.479427 12378 kserver.cc:163] Server-wide thread pool size limit: 3276
20:04:01.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.553711 12378 rpc_server.cc:307] RPC server started. Bound to: 127.12.2.61:45125
20:04:01.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.553833 12450 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.2.61:45125 every 8 connection(s)
20:04:01.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.556609 12378 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/data/info.pb
20:04:01.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.560199 12296 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu as pid 12378
20:04:01.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.560655 12296 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-1/wal/instance
20:04:01.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.563544 12296 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:04:01.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:04:01.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/wal
20:04:01.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/data
20:04:01.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:04:01.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:04:01.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:04:01.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:04:01.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:04:01.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:04:01.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/logs
20:04:01.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/data/info.pb
20:04:01.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:04:01.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:04:01.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:04:01.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:04:01.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:04:01.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:04:01.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:04:01.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:04:01.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
20:04:01.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:04:01.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:04:01.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:04:01.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.60:40835
20:04:01.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.60
20:04:01.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:04:01.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:04:01.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:04:01.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:04:01.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:04:01.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:04:01.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:04:01.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:04:01.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36407/jwks.json with env {}
20:04:01.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.565877 12451 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
20:04:01.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.582357 12451 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } has no permanent_uuid. Determining permanent_uuid...
20:04:01.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.606407 12451 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } has no permanent_uuid. Determining permanent_uuid...
20:04:01.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.620021 12451 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } has no permanent_uuid. Determining permanent_uuid...
20:04:01.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.622206 12400 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:01.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.626479 12451 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:01.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.676074 12451 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 1
20:04:01.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.681073 12451 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:01.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.749541 12451 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 2
20:04:01.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.753556 12451 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:01.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.844959 12451 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 3
20:04:01.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.851104 12451 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:01.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.896219 12453 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:04:01.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.896766 12453 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:04:01.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.897217 12453 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:04:01.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.930510 12453 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
20:04:01.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.930806 12453 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:04:01.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.931008 12453 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
20:04:01.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.931190 12453 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
20:04:01.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.931371 12453 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
20:04:01.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.931540 12453 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36407/jwks.json
20:04:01.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.969785 12453 master_runner.cc:387] Master server non-default flags:
20:04:01.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:04:01.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:04:01.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:04:01.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/data
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/wal
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.60:40835
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36407/jwks.json
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:04:01.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/data/info.pb
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.60
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/logs
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
20:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:04:01.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 19:43:23 UTC on e7f111948823
20:04:01.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11963
20:04:01.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:04:01.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.971465 12453 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:04:01.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.973747 12453 file_cache.cc:492] Constructed file cache file cache with capacity 419430
20:04:01.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.986385 12463 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:01.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:01.994555 12451 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 4
20:04:02.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:02.002111 12451 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:02.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:02.068601 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } attempt: 7
20:04:02.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:02.088939 12376 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } has no permanent_uuid. Determining permanent_uuid...
20:04:02.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:02.109279 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:02.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:02.168758 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 1
20:04:02.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:02.176592 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:02.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:02.258160 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 2
20:04:02.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:02.265862 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:02.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:02.304847 12451 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 5
20:04:02.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:02.313669 12451 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:02.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:02.351409 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 3
20:04:02.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:02.359289 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:02.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:02.499869 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 4
20:04:02.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:02.508042 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:02.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:02.791594 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 5
20:04:02.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:02.799641 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:02.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:02.861269 12451 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 6
20:04:02.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:02.889549 12451 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:03.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.352227 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 6
20:04:03.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:03.378176 12376 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:03.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:03.389317 12462 debug-util.cc:398] Leaking SignalData structure 0x7b08000271e0 after lost signal to thread 12453
20:04:03.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:03.863122 12462 kernel_stack_watchdog.cc:198] Thread 12453 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 400ms:
20:04:03.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
20:04:03.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
20:04:03.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
20:04:03.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
20:04:03.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:03.863942 12453 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.877s	user 0.729s	sys 1.138s
20:04:03.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:03.864462 12453 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.878s	user 0.729s	sys 1.138s
20:04:03.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:01.987665 12464 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:03.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:03.865449 12465 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1876 milliseconds
20:04:03.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.866406 12453 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
20:04:03.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:03.866674 12466 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:03.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.870039 12453 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:04:03.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.873380 12453 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:04:03.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.874782 12453 hybrid_clock.cc:648] HybridClock initialized: now 1779134643874744 us; error 39 us; skew 500 ppm
20:04:03.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.875844 12453 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:04:03.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.882900 12453 webserver.cc:533] Webserver started at http://127.12.2.60:34021/ using document root <none> and password file <none>
20:04:03.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.883965 12453 fs_manager.cc:362] Metadata directory not provided
20:04:03.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.884214 12453 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:04:03.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.884785 12453 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:04:03.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.889318 12453 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/data/instance:
20:04:03.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "26f39ddf93d346ecaaaf0c76819d766a"
20:04:03.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:03 on dist-test-slave-x560"
20:04:03.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.890600 12453 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/wal/instance:
20:04:03.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "26f39ddf93d346ecaaaf0c76819d766a"
20:04:03.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:03 on dist-test-slave-x560"
20:04:03.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.898272 12453 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.002s	sys 0.006s
20:04:03.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.904727 12479 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:04:03.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.905997 12453 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.001s
20:04:03.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.906360 12453 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/data,/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/wal
20:04:03.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "26f39ddf93d346ecaaaf0c76819d766a"
20:04:03.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:03 on dist-test-slave-x560"
20:04:03.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.906791 12453 fs_report.cc:389] FS layout report
20:04:03.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:04:03.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/wal
20:04:03.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/wal
20:04:03.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/data/data
20:04:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:04:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:04:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:04:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:04:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:04:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:04:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:04:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:04:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:04:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:04:03.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:04:03.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.950148 12451 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 7
20:04:03.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:03.957784 12451 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.2.60:40835: Network error: Client connection negotiation failed: client connection to 127.12.2.60:40835: connect: Connection refused (error 111)
20:04:03.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.979280 12453 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:04:03.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.980965 12453 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
20:04:03.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:03.981523 12453 kserver.cc:163] Server-wide thread pool size limit: 3276
20:04:04.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.148626 12453 rpc_server.cc:307] RPC server started. Bound to: 127.12.2.60:40835
20:04:04.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.148940 12532 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.2.60:40835 every 8 connection(s)
20:04:04.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.154296 12453 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/data/info.pb
20:04:04.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.162902 12296 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu as pid 12453
20:04:04.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.163399 12296 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/master-2/wal/instance
20:04:04.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.167806 12533 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
20:04:04.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.199112 12533 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } has no permanent_uuid. Determining permanent_uuid...
20:04:04.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.228453 12533 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } has no permanent_uuid. Determining permanent_uuid...
20:04:04.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.244201 12533 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } has no permanent_uuid. Determining permanent_uuid...
20:04:04.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.268388 12533 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a: Bootstrap starting.
20:04:04.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.276372 12533 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a: Neither blocks nor log segments found. Creating new log.
20:04:04.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.279819 12533 log.cc:826] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a: Log is configured to *not* fsync() on all Append() calls
20:04:04.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.288177 12533 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a: No bootstrap required, opened a new log
20:04:04.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.316462 12533 raft_consensus.cc:359] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } }
20:04:04.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.317477 12533 raft_consensus.cc:385] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:04:04.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.317788 12533 raft_consensus.cc:740] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 26f39ddf93d346ecaaaf0c76819d766a, State: Initialized, Role: FOLLOWER
20:04:04.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.318697 12533 consensus_queue.cc:260] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [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: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } }
20:04:04.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.323544 12541 sys_catalog.cc:455] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [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: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } } }
20:04:04.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.324970 12541 sys_catalog.cc:458] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [sys.catalog]: This master's current role is: FOLLOWER
20:04:04.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.326900 12533 sys_catalog.cc:565] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [sys.catalog]: configured and running, proceeding with master startup.
20:04:04.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:04.383744 12552 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
20:04:04.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:04.384907 12552 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
20:04:04.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.411790 12376 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 7
20:04:04.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.372531 12453 master_runner.cc:187] Error getting master registration for 127.12.2.62:43383: OK, instance_id { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" instance_seqno: 1779134639695114 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
20:04:04.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.414906 12453 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
20:04:04.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.432178 12376 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927: Bootstrap starting.
20:04:04.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.437738 12376 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927: Neither blocks nor log segments found. Creating new log.
20:04:04.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.439761 12376 log.cc:826] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927: Log is configured to *not* fsync() on all Append() calls
20:04:04.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.447419 12376 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927: No bootstrap required, opened a new log
20:04:04.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.478129 12376 raft_consensus.cc:359] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } }
20:04:04.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.479050 12376 raft_consensus.cc:385] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:04:04.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.479339 12376 raft_consensus.cc:740] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: dfd308518f0042e9b2ce90a3dbd16927, State: Initialized, Role: FOLLOWER
20:04:04.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.480262 12376 consensus_queue.cc:260] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [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: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } }
20:04:04.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.483259 12556 sys_catalog.cc:455] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [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: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } } }
20:04:04.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.484114 12541 raft_consensus.cc:493] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
20:04:04.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.484365 12556 sys_catalog.cc:458] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [sys.catalog]: This master's current role is: FOLLOWER
20:04:04.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.484733 12541 raft_consensus.cc:515] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } }
20:04:04.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.485409 12376 sys_catalog.cc:565] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [sys.catalog]: configured and running, proceeding with master startup.
20:04:04.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:04.487396 12487 tablet.cc:2404] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:04:04.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.491959 12351 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "26f39ddf93d346ecaaaf0c76819d766a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "dfd308518f0042e9b2ce90a3dbd16927" is_pre_election: true
20:04:04.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.492868 12351 raft_consensus.cc:2468] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 26f39ddf93d346ecaaaf0c76819d766a in term 0.
20:04:04.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.494357 12482 leader_election.cc:304] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [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: 26f39ddf93d346ecaaaf0c76819d766a, dfd308518f0042e9b2ce90a3dbd16927; no voters: 
20:04:04.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.494796 12541 leader_election.cc:290] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers dfd308518f0042e9b2ce90a3dbd16927 (127.12.2.62:43383), ea9341342a574258abbd9edcff0e40c5 (127.12.2.61:45125)
20:04:04.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.498180 12541 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [term 0 FOLLOWER]: Leader pre-election won for term 1
20:04:04.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.498797 12541 raft_consensus.cc:493] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
20:04:04.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.499464 12541 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [term 0 FOLLOWER]: Advancing to term 1
20:04:04.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.519345 12541 raft_consensus.cc:515] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } }
20:04:04.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.523077 12351 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "26f39ddf93d346ecaaaf0c76819d766a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "dfd308518f0042e9b2ce90a3dbd16927"
20:04:04.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.523649 12351 raft_consensus.cc:3060] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [term 0 FOLLOWER]: Advancing to term 1
20:04:04.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.531042 12351 raft_consensus.cc:2468] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 26f39ddf93d346ecaaaf0c76819d766a in term 1.
20:04:04.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.532601 12541 leader_election.cc:290] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [CANDIDATE]: Term 1 election: Requested vote from peers dfd308518f0042e9b2ce90a3dbd16927 (127.12.2.62:43383), ea9341342a574258abbd9edcff0e40c5 (127.12.2.61:45125)
20:04:04.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.534555 12482 leader_election.cc:304] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [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: 26f39ddf93d346ecaaaf0c76819d766a, dfd308518f0042e9b2ce90a3dbd16927; no voters: 
20:04:04.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.535513 12541 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [term 1 FOLLOWER]: Leader election won for term 1
20:04:04.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.537959 12541 raft_consensus.cc:697] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [term 1 LEADER]: Becoming Leader. State: Replica: 26f39ddf93d346ecaaaf0c76819d766a, State: Running, Role: LEADER
20:04:04.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.540195 12541 consensus_queue.cc:237] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [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: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } }
20:04:04.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.549990 12558 sys_catalog.cc:455] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [sys.catalog]: SysCatalogTable state changed. Reason: New leader 26f39ddf93d346ecaaaf0c76819d766a. Latest consensus state: current_term: 1 leader_uuid: "26f39ddf93d346ecaaaf0c76819d766a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } } }
20:04:04.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.550864 12558 sys_catalog.cc:458] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [sys.catalog]: This master's current role is: LEADER
20:04:04.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.566603 12568 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
20:04:04.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.574522 12568 catalog_manager.cc:1519] Initializing Kudu cluster ID...
20:04:04.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.580425 12570 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
20:04:04.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.601579 12351 raft_consensus.cc:1275] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [term 1 FOLLOWER]: Refusing update from remote peer 26f39ddf93d346ecaaaf0c76819d766a: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
20:04:04.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.603382 12541 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [LEADER]: Connected to new peer: Peer: permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
20:04:04.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.590553 12308 master_runner.cc:187] Error getting master registration for 127.12.2.61:45125: OK, instance_id { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" instance_seqno: 1779134641533469 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
20:04:04.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.640323 12308 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
20:04:04.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.654081 12556 sys_catalog.cc:455] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 26f39ddf93d346ecaaaf0c76819d766a. Latest consensus state: current_term: 1 leader_uuid: "26f39ddf93d346ecaaaf0c76819d766a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } } }
20:04:04.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.664868 12571 mvcc.cc:204] Tried to move back new op lower bound from 7287335504269221888 to 7287335504050917376. Current Snapshot: MvccSnapshot[applied={T|T < 7287335504269221888}]
20:04:04.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:04.655150 12330 tablet.cc:2404] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:04:04.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.667538 12558 sys_catalog.cc:455] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "26f39ddf93d346ecaaaf0c76819d766a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } } }
20:04:04.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.668233 12558 sys_catalog.cc:458] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [sys.catalog]: This master's current role is: LEADER
20:04:04.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.670253 12556 sys_catalog.cc:458] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [sys.catalog]: This master's current role is: FOLLOWER
20:04:04.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.671249 12568 catalog_manager.cc:1382] Generated new cluster ID: 4a48118fcf014bc99125528fe885d8ac
20:04:04.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.672595 12568 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
20:04:04.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.681910 12556 sys_catalog.cc:455] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "26f39ddf93d346ecaaaf0c76819d766a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } } }
20:04:04.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.683149 12556 sys_catalog.cc:458] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927 [sys.catalog]: This master's current role is: FOLLOWER
20:04:04.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.712949 12568 catalog_manager.cc:1405] Generated new certificate authority record
20:04:04.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.715533 12568 catalog_manager.cc:1539] Loading token signing keys...
20:04:04.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.760720 12568 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a: Generated new TSK 0
20:04:04.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.762300 12568 catalog_manager.cc:1549] Initializing in-progress tserver states...
20:04:04.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:04.798385 12296 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:04:04.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:04:04.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/wal
20:04:04.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/data
20:04:04.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:04:04.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:04:04.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:04:04.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:04:04.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:04:04.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:04:04.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/logs
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/data/info.pb
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.1:0
20:04:04.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.2.1
20:04:04.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.1
20:04:04.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:04:04.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:04:04.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:04:04.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:04:04.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:04:04.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
20:04:05.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:05.399940 12577 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:04:05.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:05.400688 12577 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:04:05.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:05.401486 12577 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:04:05.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:05.469079 12577 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:04:05.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:05.470583 12577 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.12.2.1
20:04:05.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:05.544400 12577 tablet_server_runner.cc:78] Tablet server non-default flags:
20:04:05.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:04:05.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:04:05.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:04:05.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:04:05.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/data
20:04:05.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/wal
20:04:05.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:04:05.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:04:05.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.1:0
20:04:05.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:04:05.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:04:05.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:04:05.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/data/info.pb
20:04:05.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.1
20:04:05.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:04:05.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:04:05.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:04:05.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:04:05.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:04:05.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:04:05.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:04:05.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.2.1
20:04:05.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/logs
20:04:05.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:04:05.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:04:05.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:04:05.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:04:05.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:04:05.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
20:04:05.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:04:05.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 19:43:23 UTC on e7f111948823
20:04:05.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11963
20:04:05.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:04:05.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:05.546226 12577 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:04:05.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:05.548444 12577 file_cache.cc:492] Constructed file cache file cache with capacity 419430
20:04:05.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:05.608174 12570 catalog_manager.cc:1294] Loaded cluster ID: 4a48118fcf014bc99125528fe885d8ac
20:04:05.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:05.611614 12570 catalog_manager.cc:1587] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927: loading cluster ID for follower catalog manager: success
20:04:05.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:05.620597 12584 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:05.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:05.627854 12570 catalog_manager.cc:1609] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927: acquiring CA information for follower catalog manager: success
20:04:05.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:05.648943 12570 catalog_manager.cc:1637] T 00000000000000000000000000000000 P dfd308518f0042e9b2ce90a3dbd16927: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
20:04:06.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.048167 12451 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } attempt: 8
20:04:06.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.105919 12451 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5: Bootstrap starting.
20:04:06.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.134521 12451 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5: Neither blocks nor log segments found. Creating new log.
20:04:06.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.143266 12451 log.cc:826] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5: Log is configured to *not* fsync() on all Append() calls
20:04:06.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.162201 12451 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5: No bootstrap required, opened a new log
20:04:06.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.263768 12451 raft_consensus.cc:359] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } }
20:04:06.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.268208 12451 raft_consensus.cc:385] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:04:06.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.284897 12451 raft_consensus.cc:740] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ea9341342a574258abbd9edcff0e40c5, State: Initialized, Role: FOLLOWER
20:04:06.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.305213 12451 consensus_queue.cc:260] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [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: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } }
20:04:06.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.339655 12593 sys_catalog.cc:455] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [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: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } } }
20:04:06.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.345283 12593 sys_catalog.cc:458] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [sys.catalog]: This master's current role is: FOLLOWER
20:04:06.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.401340 12426 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "26f39ddf93d346ecaaaf0c76819d766a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ea9341342a574258abbd9edcff0e40c5" is_pre_election: true
20:04:06.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.402787 12426 raft_consensus.cc:2468] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 26f39ddf93d346ecaaaf0c76819d766a in term 0.
20:04:06.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.406363 12424 raft_consensus.cc:3060] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [term 0 FOLLOWER]: Advancing to term 1
20:04:06.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:06.403823 12426 rpcz_store.cc:267] Call kudu.consensus.ConsensusService.RequestConsensusVote from 127.0.0.1:59916 (request call id 1) took 1912 ms (client timeout 2222 ms). Trace:
20:04:06.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:06.414559 12426 rpcz_store.cc:269] 0518 20:04:04.491268 (+     0us) service_pool.cc:167] Inserting onto call queue
20:04:06.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0518 20:04:04.493528 (+  2260us) service_pool.cc:224] Handling call
20:04:06.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0518 20:04:06.403715 (+1910187us) inbound_call.cc:177] Queueing success response
20:04:06.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {}
20:04:06.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.410890 12425 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "26f39ddf93d346ecaaaf0c76819d766a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ea9341342a574258abbd9edcff0e40c5"
20:04:06.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:06.427451 12425 rpcz_store.cc:267] Call kudu.consensus.ConsensusService.RequestConsensusVote from 127.0.0.1:59916 (request call id 2) took 1893 ms (client timeout 2010 ms). Trace:
20:04:06.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:06.429284 12425 rpcz_store.cc:269] 0518 20:04:04.534131 (+     0us) service_pool.cc:167] Inserting onto call queue
20:04:06.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0518 20:04:04.534319 (+   188us) service_pool.cc:224] Handling call
20:04:06.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0518 20:04:06.427353 (+1893034us) inbound_call.cc:177] Queueing success response
20:04:06.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {}
20:04:06.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.445297 12451 sys_catalog.cc:565] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [sys.catalog]: configured and running, proceeding with master startup.
20:04:06.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.453150 12424 raft_consensus.cc:1275] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [term 1 FOLLOWER]: Refusing update from remote peer 26f39ddf93d346ecaaaf0c76819d766a: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
20:04:06.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.475010 12424 rpcz_store.cc:275] Call kudu.consensus.ConsensusService.UpdateConsensus from 127.0.0.1:59916 (request call id 3) took 1875 ms. Trace:
20:04:06.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.481594 12424 rpcz_store.cc:276] 0518 20:04:04.600095 (+     0us) service_pool.cc:167] Inserting onto call queue
20:04:06.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0518 20:04:04.600671 (+   576us) service_pool.cc:224] Handling call
20:04:06.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0518 20:04:06.405569 (+1804898us) raft_consensus.cc:1471] Updating replica for 0 ops
20:04:06.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0518 20:04:06.474410 (+ 68841us) raft_consensus.cc:1697] Filling consensus response to leader.
20:04:06.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0518 20:04:06.474907 (+   497us) inbound_call.cc:177] Queueing success response
20:04:06.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {}
20:04:06.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:06.490558 12405 tablet.cc:2404] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:04:06.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.495417 12596 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [LEADER]: Connected to new peer: Peer: permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
20:04:06.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.686333 12593 sys_catalog.cc:455] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 26f39ddf93d346ecaaaf0c76819d766a. Latest consensus state: current_term: 1 leader_uuid: "26f39ddf93d346ecaaaf0c76819d766a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } } }
20:04:06.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.686762 12604 sys_catalog.cc:455] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "26f39ddf93d346ecaaaf0c76819d766a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } } }
20:04:06.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.687616 12593 sys_catalog.cc:458] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [sys.catalog]: This master's current role is: FOLLOWER
20:04:06.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.687685 12604 sys_catalog.cc:458] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5 [sys.catalog]: This master's current role is: FOLLOWER
20:04:06.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.704326 12610 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
20:04:06.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.984289 12596 sys_catalog.cc:455] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "26f39ddf93d346ecaaaf0c76819d766a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dfd308518f0042e9b2ce90a3dbd16927" member_type: VOTER last_known_addr { host: "127.12.2.62" port: 43383 } } peers { permanent_uuid: "ea9341342a574258abbd9edcff0e40c5" member_type: VOTER last_known_addr { host: "127.12.2.61" port: 45125 } } peers { permanent_uuid: "26f39ddf93d346ecaaaf0c76819d766a" member_type: VOTER last_known_addr { host: "127.12.2.60" port: 40835 } } }
20:04:06.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:06.985728 12596 sys_catalog.cc:458] T 00000000000000000000000000000000 P 26f39ddf93d346ecaaaf0c76819d766a [sys.catalog]: This master's current role is: LEADER
20:04:07.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:07.744338 12610 catalog_manager.cc:1294] Loaded cluster ID: 4a48118fcf014bc99125528fe885d8ac
20:04:07.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:07.744697 12610 catalog_manager.cc:1587] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5: loading cluster ID for follower catalog manager: success
20:04:07.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:07.776490 12610 catalog_manager.cc:1609] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5: acquiring CA information for follower catalog manager: success
20:04:07.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:07.800901 12610 catalog_manager.cc:1637] T 00000000000000000000000000000000 P ea9341342a574258abbd9edcff0e40c5: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
20:04:08.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:06.981626 12583 debug-util.cc:398] Leaking SignalData structure 0x7b08000271c0 after lost signal to thread 12577
20:04:08.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:08.434733 12583 kernel_stack_watchdog.cc:198] Thread 12577 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 347ms:
20:04:08.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
20:04:08.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
20:04:08.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
20:04:08.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
20:04:08.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:08.435117 12577 thread.cc:641] GCE (cloud detector) Time spent creating pthread: real 2.804s	user 0.929s	sys 1.556s
20:04:08.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:05.643661 12586 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:08.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:08.435997 12577 thread.cc:608] GCE (cloud detector) Time spent starting thread: real 2.805s	user 0.929s	sys 1.557s
20:04:08.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.443764 12577 server_base.cc:1061] running on GCE node
20:04:08.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:08.444604 12617 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:08.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.446065 12577 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:04:08.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.448872 12577 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:04:08.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.450305 12577 hybrid_clock.cc:648] HybridClock initialized: now 1779134648450149 us; error 148 us; skew 500 ppm
20:04:08.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.451378 12577 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:04:08.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.461691 12577 webserver.cc:533] Webserver started at http://127.12.2.1:39027/ using document root <none> and password file <none>
20:04:08.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.462877 12577 fs_manager.cc:362] Metadata directory not provided
20:04:08.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.463146 12577 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:04:08.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.463730 12577 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:04:08.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.470180 12577 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/data/instance:
20:04:08.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6ccc508628554c988adee1ef348e2fe3"
20:04:08.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:08 on dist-test-slave-x560"
20:04:08.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.471665 12577 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/wal/instance:
20:04:08.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6ccc508628554c988adee1ef348e2fe3"
20:04:08.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:08 on dist-test-slave-x560"
20:04:08.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.481724 12577 fs_manager.cc:696] Time spent creating directory manager: real 0.009s	user 0.009s	sys 0.002s
20:04:08.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.489293 12622 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:04:08.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.490612 12577 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.004s	sys 0.000s
20:04:08.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.490988 12577 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/data,/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/wal
20:04:08.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6ccc508628554c988adee1ef348e2fe3"
20:04:08.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:08 on dist-test-slave-x560"
20:04:08.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.491413 12577 fs_report.cc:389] FS layout report
20:04:08.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:04:08.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/wal
20:04:08.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/wal
20:04:08.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/data/data
20:04:08.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:04:08.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:04:08.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:04:08.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:04:08.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:04:08.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:04:08.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:04:08.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:04:08.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:04:08.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:04:08.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:04:08.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.566355 12577 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:04:08.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.568212 12577 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
20:04:08.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.568771 12577 kserver.cc:163] Server-wide thread pool size limit: 3276
20:04:08.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.593932 12577 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:04:08.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.605592 12577 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:04:08.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.605841 12577 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
20:04:08.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.606119 12577 ts_tablet_manager.cc:616] Registered 0 tablets
20:04:08.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:08.606331 12577 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
20:04:09.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.104624 12577 rpc_server.cc:307] RPC server started. Bound to: 127.12.2.1:42723
20:04:09.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.104818 12734 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.2.1:42723 every 8 connection(s)
20:04:09.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.108248 12577 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/data/info.pb
20:04:09.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.115677 12296 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu as pid 12577
20:04:09.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.116634 12296 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-0/wal/instance
20:04:09.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.152551 12296 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:04:09.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:04:09.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/wal
20:04:09.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/data
20:04:09.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:04:09.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:04:09.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/logs
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/data/info.pb
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:04:09.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:04:09.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:04:09.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:04:09.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:04:09.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.2:0
20:04:09.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.2.2
20:04:09.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.2
20:04:09.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:04:09.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:04:09.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:04:09.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:04:09.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:04:09.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
20:04:09.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.263165 12741 heartbeater.cc:344] Connected to a master server at 127.12.2.62:43383
20:04:09.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.263849 12741 heartbeater.cc:461] Registering TS with master...
20:04:09.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.265767 12741 heartbeater.cc:507] Master 127.12.2.62:43383 requested a full tablet report, sending...
20:04:09.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.267755 12736 heartbeater.cc:344] Connected to a master server at 127.12.2.61:45125
20:04:09.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.268187 12736 heartbeater.cc:461] Registering TS with master...
20:04:09.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.270386 12736 heartbeater.cc:507] Master 127.12.2.61:45125 requested a full tablet report, sending...
20:04:09.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.277937 12416 ts_manager.cc:194] Registered new tserver with Master: 6ccc508628554c988adee1ef348e2fe3 (127.12.2.1:42723)
20:04:09.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.280810 12735 heartbeater.cc:344] Connected to a master server at 127.12.2.60:40835
20:04:09.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.281489 12735 heartbeater.cc:461] Registering TS with master...
20:04:09.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.281369 12341 ts_manager.cc:194] Registered new tserver with Master: 6ccc508628554c988adee1ef348e2fe3 (127.12.2.1:42723)
20:04:09.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.283099 12735 heartbeater.cc:507] Master 127.12.2.60:40835 requested a full tablet report, sending...
20:04:09.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.286077 12498 ts_manager.cc:194] Registered new tserver with Master: 6ccc508628554c988adee1ef348e2fe3 (127.12.2.1:42723)
20:04:09.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.288755 12498 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.12.2.1:42109
20:04:09.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:09.760507 12745 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:04:09.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:09.761256 12745 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:04:09.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:09.761945 12745 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:04:09.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:09.800580 12745 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:04:09.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:09.801431 12745 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.12.2.2
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.840649 12745 tablet_server_runner.cc:78] Tablet server non-default flags:
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/data
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/wal
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.2:0
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:04:09.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/data/info.pb
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.2
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.2.2
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/logs
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:04:09.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
20:04:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:04:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 19:43:23 UTC on e7f111948823
20:04:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11963
20:04:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:04:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.841966 12745 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:04:09.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:09.843586 12745 file_cache.cc:492] Constructed file cache file cache with capacity 419430
20:04:09.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:09.862026 12751 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:10.293622 12735 heartbeater.cc:499] Master 127.12.2.60:40835 was elected leader, sending a full tablet report...
20:04:11.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:11.264957 12750 debug-util.cc:398] Leaking SignalData structure 0x7b08000271c0 after lost signal to thread 12745
20:04:11.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:11.856791 12745 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.990s	user 0.654s	sys 1.142s
20:04:11.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:11.857323 12745 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.991s	user 0.654s	sys 1.142s
20:04:11.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:09.866233 12752 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:11.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:11.860306 12754 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:11.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:11.866984 12753 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1997 milliseconds
20:04:11.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.867019 12745 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
20:04:11.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.868327 12745 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:04:11.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.871104 12745 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:04:11.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.872449 12745 hybrid_clock.cc:648] HybridClock initialized: now 1779134651872413 us; error 68 us; skew 500 ppm
20:04:11.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.873332 12745 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:04:11.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.883760 12745 webserver.cc:533] Webserver started at http://127.12.2.2:34355/ using document root <none> and password file <none>
20:04:11.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.885066 12745 fs_manager.cc:362] Metadata directory not provided
20:04:11.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.885392 12745 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:04:11.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.885991 12745 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:04:11.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.892331 12745 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/data/instance:
20:04:11.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5859d48a6c344a839195e24d4fe113b5"
20:04:11.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:11 on dist-test-slave-x560"
20:04:11.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.893472 12745 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/wal/instance:
20:04:11.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5859d48a6c344a839195e24d4fe113b5"
20:04:11.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:11 on dist-test-slave-x560"
20:04:11.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.900662 12745 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.005s	sys 0.001s
20:04:11.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.906174 12764 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:04:11.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.907182 12745 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.002s
20:04:11.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.907564 12745 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/data,/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/wal
20:04:11.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5859d48a6c344a839195e24d4fe113b5"
20:04:11.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:11 on dist-test-slave-x560"
20:04:11.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.907904 12745 fs_report.cc:389] FS layout report
20:04:11.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:04:11.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/wal
20:04:11.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/wal
20:04:11.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/data/data
20:04:11.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:04:11.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:04:11.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:04:11.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:04:11.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:04:11.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:04:11.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:04:11.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:04:11.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:04:11.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:04:11.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:04:11.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.970805 12745 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.972586 12745 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
20:04:11.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.973110 12745 kserver.cc:163] Server-wide thread pool size limit: 3276
20:04:11.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.975924 12745 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:04:11.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.980233 12745 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:04:11.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.980463 12745 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
20:04:11.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.980808 12745 ts_tablet_manager.cc:616] Registered 0 tablets
20:04:11.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:11.981019 12745 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
20:04:12.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.240165 12745 rpc_server.cc:307] RPC server started. Bound to: 127.12.2.2:37789
20:04:12.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.240388 12876 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.2.2:37789 every 8 connection(s)
20:04:12.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.243069 12745 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/data/info.pb
20:04:12.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.248098 12296 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu as pid 12745
20:04:12.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.248636 12296 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-1/wal/instance
20:04:12.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.284924 12296 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:04:12.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/wal
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/data
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/logs
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/data/info.pb
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:04:12.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:04:12.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:04:12.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:04:12.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:04:12.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:04:12.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:04:12.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:04:12.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:04:12.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.3:0
20:04:12.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.2.3
20:04:12.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.3
20:04:12.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:04:12.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:04:12.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:04:12.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:04:12.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:04:12.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
20:04:12.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.369210 12877 heartbeater.cc:344] Connected to a master server at 127.12.2.60:40835
20:04:12.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.369925 12877 heartbeater.cc:461] Registering TS with master...
20:04:12.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.372123 12877 heartbeater.cc:507] Master 127.12.2.60:40835 requested a full tablet report, sending...
20:04:12.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.374472 12878 heartbeater.cc:344] Connected to a master server at 127.12.2.61:45125
20:04:12.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.374976 12878 heartbeater.cc:461] Registering TS with master...
20:04:12.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.376891 12878 heartbeater.cc:507] Master 127.12.2.61:45125 requested a full tablet report, sending...
20:04:12.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.377457 12498 ts_manager.cc:194] Registered new tserver with Master: 5859d48a6c344a839195e24d4fe113b5 (127.12.2.2:37789)
20:04:12.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.380244 12498 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.12.2.2:43565
20:04:12.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.380846 12880 heartbeater.cc:344] Connected to a master server at 127.12.2.62:43383
20:04:12.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.381471 12880 heartbeater.cc:461] Registering TS with master...
20:04:12.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.381841 12416 ts_manager.cc:194] Registered new tserver with Master: 5859d48a6c344a839195e24d4fe113b5 (127.12.2.2:37789)
20:04:12.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.383445 12880 heartbeater.cc:507] Master 127.12.2.62:43383 requested a full tablet report, sending...
20:04:12.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.387404 12341 ts_manager.cc:194] Registered new tserver with Master: 5859d48a6c344a839195e24d4fe113b5 (127.12.2.2:37789)
20:04:12.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:12.857496 12887 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:04:12.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:12.858014 12887 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:04:12.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:12.858409 12887 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:04:12.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:12.895097 12887 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:04:12.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:12.895871 12887 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.12.2.3
20:04:12.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.933465 12887 tablet_server_runner.cc:78] Tablet server non-default flags:
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.2.20:33547
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/data
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/wal
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.2.3:0
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/data/info.pb
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.2.3
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:04:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.2.62:43383,127.12.2.61:45125,127.12.2.60:40835
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.2.3
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/logs
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 19:43:23 UTC on e7f111948823
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11963
20:04:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:04:12.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.934803 12887 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:04:12.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:12.936491 12887 file_cache.cc:492] Constructed file cache file cache with capacity 419430
20:04:12.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:12.951399 12894 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:13.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:13.386525 12877 heartbeater.cc:499] Master 127.12.2.60:40835 was elected leader, sending a full tablet report...
20:04:14.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:12.329573 12305 outbound_call.cc:321] RPC callback for RPC call kudu.master.MasterService.ConnectToMaster -> {remote=127.12.2.60:40835, user_credentials={real_user=slave}} blocked reactor thread for 47341us
20:04:14.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:14.402808 12529 debug-util.cc:398] Leaking SignalData structure 0x7b0800070060 after lost signal to thread 12458
20:04:14.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:14.403899 12529 debug-util.cc:398] Leaking SignalData structure 0x7b080009b240 after lost signal to thread 12532
20:04:14.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:14.692909 12731 debug-util.cc:398] Leaking SignalData structure 0x7b08000ac100 after lost signal to thread 12578
20:04:14.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:14.694247 12731 debug-util.cc:398] Leaking SignalData structure 0x7b08000ace40 after lost signal to thread 12734
20:04:15.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:15.424332 12447 debug-util.cc:398] Leaking SignalData structure 0x7b08000708a0 after lost signal to thread 12382
20:04:15.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:15.425933 12447 debug-util.cc:398] Leaking SignalData structure 0x7b0800091920 after lost signal to thread 12450
20:04:15.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:14.355916 12893 debug-util.cc:398] Leaking SignalData structure 0x7b08000271c0 after lost signal to thread 12887
20:04:15.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:15.618005 12887 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 2.665s	user 0.839s	sys 1.358s
20:04:15.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:15.621861 12887 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 2.669s	user 0.839s	sys 1.358s
20:04:15.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:12.953263 12895 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:15.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:15.622681 12897 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
20:04:15.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:15.628685 12896 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection timed out after 2675 milliseconds
20:04:15.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.629763 12887 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
20:04:15.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.631959 12887 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:04:15.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.653898 12887 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:04:15.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.655850 12887 hybrid_clock.cc:648] HybridClock initialized: now 1779134655655808 us; error 51 us; skew 500 ppm
20:04:15.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.657220 12887 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:04:15.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.676321 12887 webserver.cc:533] Webserver started at http://127.12.2.3:42911/ using document root <none> and password file <none>
20:04:15.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.678184 12887 fs_manager.cc:362] Metadata directory not provided
20:04:15.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.678741 12887 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:04:15.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.679482 12887 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:04:15.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.688367 12887 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/data/instance:
20:04:15.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d86950dd911048da9de737ee58d8c90a"
20:04:15.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:15 on dist-test-slave-x560"
20:04:15.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.691066 12887 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/wal/instance:
20:04:15.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d86950dd911048da9de737ee58d8c90a"
20:04:15.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:15 on dist-test-slave-x560"
20:04:15.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.710176 12887 fs_manager.cc:696] Time spent creating directory manager: real 0.018s	user 0.013s	sys 0.002s
20:04:15.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.729569 12905 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:04:15.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.731199 12887 fs_manager.cc:730] Time spent opening block manager: real 0.012s	user 0.000s	sys 0.008s
20:04:15.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.731873 12887 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/data,/tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/wal
20:04:15.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d86950dd911048da9de737ee58d8c90a"
20:04:15.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 20:04:15 on dist-test-slave-x560"
20:04:15.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.732651 12887 fs_report.cc:389] FS layout report
20:04:15.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:04:15.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/wal
20:04:15.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/wal
20:04:15.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/data/data
20:04:15.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:04:15.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:04:15.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:04:15.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:04:15.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:04:15.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:04:15.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:04:15.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:04:15.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:04:15.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:04:15.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:04:15.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.840643 12887 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:04:15.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.843429 12887 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
20:04:15.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.844311 12887 kserver.cc:163] Server-wide thread pool size limit: 3276
20:04:15.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.854853 12887 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:04:15.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.869421 12887 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:04:15.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.870085 12887 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.001s	user 0.000s	sys 0.000s
20:04:15.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.870705 12887 ts_tablet_manager.cc:616] Registered 0 tablets
20:04:15.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:15.871356 12887 ts_tablet_manager.cc:595] Time spent register tablets: real 0.001s	user 0.001s	sys 0.000s
20:04:16.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:16.928258 13017 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.2.3:44461 every 8 connection(s)
20:04:16.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:16.928784 12887 rpc_server.cc:307] RPC server started. Bound to: 127.12.2.3:44461
20:04:16.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:16.935036 12887 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/data/info.pb
20:04:16.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:16.942718 12296 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu as pid 12887
20:04:16.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:16.943238 12296 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskSYXuPB/test-tmp/mini-kudu-cluster730791422435712574/ts-2/wal/instance
20:04:17.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.036060 13021 heartbeater.cc:344] Connected to a master server at 127.12.2.61:45125
20:04:17.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.036713 13021 heartbeater.cc:461] Registering TS with master...
20:04:17.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.038749 13021 heartbeater.cc:507] Master 127.12.2.61:45125 requested a full tablet report, sending...
20:04:17.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.043125 12416 ts_manager.cc:194] Registered new tserver with Master: d86950dd911048da9de737ee58d8c90a (127.12.2.3:44461)
20:04:17.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.057916 13024 heartbeater.cc:344] Connected to a master server at 127.12.2.62:43383
20:04:17.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.058426 13024 heartbeater.cc:461] Registering TS with master...
20:04:17.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.060009 13024 heartbeater.cc:507] Master 127.12.2.62:43383 requested a full tablet report, sending...
20:04:17.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.063882 12340 ts_manager.cc:194] Registered new tserver with Master: d86950dd911048da9de737ee58d8c90a (127.12.2.3:44461)
20:04:17.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.069409 13018 heartbeater.cc:344] Connected to a master server at 127.12.2.60:40835
20:04:17.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.069892 13018 heartbeater.cc:461] Registering TS with master...
20:04:17.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.071617 13018 heartbeater.cc:507] Master 127.12.2.60:40835 requested a full tablet report, sending...
20:04:17.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.074875 12498 ts_manager.cc:194] Registered new tserver with Master: d86950dd911048da9de737ee58d8c90a (127.12.2.3:44461)
20:04:17.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.087304 12296 external_mini_cluster.cc:949] 3 TS(s) registered with all masters
20:04:17.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:17.091001 12498 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.12.2.3:34081
20:04:17.117 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
20:04:17.119 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

20:04:17.141 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.12.2.62"
      port: 43383
    }
    bound_http_address {
      host: "127.12.2.62"
      port: 35163
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.12.2.61"
      port: 45125
    }
    bound_http_address {
      host: "127.12.2.61"
      port: 35787
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.12.2.60"
      port: 40835
    }
    bound_http_address {
      host: "127.12.2.60"
      port: 34021
    }
  }
}

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

20:04:17.152 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.12.2.1"
      port: 42723
    }
    bound_http_address {
      host: "127.12.2.1"
      port: 39027
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.12.2.2"
      port: 37789
    }
    bound_http_address {
      host: "127.12.2.2"
      port: 34355
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.12.2.3"
      port: 44461
    }
    bound_http_address {
      host: "127.12.2.3"
      port: 42911
    }
  }
}

20:04:17.152 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
20:04:17.653 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttemptAndReport(RetryRule.java:184)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:244)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
20:04:17.799 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
20:04:18.064 [DEBUG - main] (Connection.java:748) [peer master-127.12.2.60:40835(127.12.2.60:40835)] connecting to peer
20:04:18.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.097005 13018 heartbeater.cc:499] Master 127.12.2.60:40835 was elected leader, sending a full tablet report...
20:04:18.139 [DEBUG - main] (Connection.java:748) [peer master-127.12.2.61:45125(127.12.2.61:45125)] connecting to peer
20:04:18.149 [DEBUG - main] (Connection.java:748) [peer master-127.12.2.62:43383(127.12.2.62:43383)] connecting to peer
20:04:18.174 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.12.2.62:43383(127.12.2.62:43383)] Successfully connected to peer
20:04:18.186 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.12.2.60:40835(127.12.2.60:40835)] Successfully connected to peer
20:04:18.186 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.12.2.61:45125(127.12.2.61:45125)] Successfully connected to peer
20:04:18.323 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.12.2.60
20:04:18.324 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.12.2.61
20:04:18.327 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.12.2.62
20:04:18.608 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x665ec31f, L:/127.0.0.1:57706 - R:/127.12.2.62:43383] using SASL/PLAIN
20:04:18.608 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xfafc33d6, L:/127.0.0.1:42604 - R:/127.12.2.61:45125] using SASL/PLAIN
20:04:18.608 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xc519dd1b, L:/127.0.0.1:40110 - R:/127.12.2.60:40835] using SASL/PLAIN
20:04:18.657 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
20:04:18.658 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=655), Traces: [0ms] refreshing cache from master, [40ms] Sub RPC ConnectToMaster: sending RPC to server master-127.12.2.60:40835, [130ms] Sub RPC ConnectToMaster: sending RPC to server master-127.12.2.61:45125, [141ms] Sub RPC ConnectToMaster: sending RPC to server master-127.12.2.62:43383, [617ms] Sub RPC ConnectToMaster: received response from server master-127.12.2.61:45125: OK, [620ms] Sub RPC ConnectToMaster: received response from server master-127.12.2.60:40835: OK, [620ms] Sub RPC ConnectToMaster: received response from server master-127.12.2.62:43383: OK, deferred=null) after lookup
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.717257 12498 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:40110:
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1779134637211"
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
20:04:18.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
20:04:18.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:04:18.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
20:04:18.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:18.720647 12498 catalog_manager.cc:7058] 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-1779134637211 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
20:04:18.811 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table d5bcca2979a8430a810a68b962c2bac8
20:04:18.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.843034 12812 tablet_service.cc:1511] Processing CreateTablet for tablet b731cb7146ce4627861654ce3d86847a (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779134637211 [id=d5bcca2979a8430a810a68b962c2bac8]), partition=RANGE (key) PARTITION UNBOUNDED
20:04:18.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.853533 12953 tablet_service.cc:1511] Processing CreateTablet for tablet b731cb7146ce4627861654ce3d86847a (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779134637211 [id=d5bcca2979a8430a810a68b962c2bac8]), partition=RANGE (key) PARTITION UNBOUNDED
20:04:18.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.855973 12953 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet b731cb7146ce4627861654ce3d86847a. 1 dirs total, 0 dirs full, 0 dirs failed
20:04:18.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.856431 12812 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet b731cb7146ce4627861654ce3d86847a. 1 dirs total, 0 dirs full, 0 dirs failed
20:04:18.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.860080 12670 tablet_service.cc:1511] Processing CreateTablet for tablet b731cb7146ce4627861654ce3d86847a (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779134637211 [id=d5bcca2979a8430a810a68b962c2bac8]), partition=RANGE (key) PARTITION UNBOUNDED
20:04:18.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.863353 12670 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet b731cb7146ce4627861654ce3d86847a. 1 dirs total, 0 dirs full, 0 dirs failed
20:04:18.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.915732 13056 tablet_bootstrap.cc:492] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3: Bootstrap starting.
20:04:18.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.929972 13056 tablet_bootstrap.cc:654] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3: Neither blocks nor log segments found. Creating new log.
20:04:18.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.934597 13056 log.cc:826] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3: Log is configured to *not* fsync() on all Append() calls
20:04:18.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.947988 13056 tablet_bootstrap.cc:492] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3: No bootstrap required, opened a new log
20:04:18.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.949005 13056 ts_tablet_manager.cc:1403] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3: Time spent bootstrapping tablet: real 0.034s	user 0.011s	sys 0.020s
20:04:18.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.959299 13055 tablet_bootstrap.cc:492] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a: Bootstrap starting.
20:04:18.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.980805 13055 tablet_bootstrap.cc:654] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a: Neither blocks nor log segments found. Creating new log.
20:04:18.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.982963 13058 tablet_bootstrap.cc:492] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5: Bootstrap starting.
20:04:18.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.988072 13055 log.cc:826] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a: Log is configured to *not* fsync() on all Append() calls
20:04:18.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.991134 13056 raft_consensus.cc:359] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5859d48a6c344a839195e24d4fe113b5" member_type: VOTER last_known_addr { host: "127.12.2.2" port: 37789 } } peers { permanent_uuid: "d86950dd911048da9de737ee58d8c90a" member_type: VOTER last_known_addr { host: "127.12.2.3" port: 44461 } } peers { permanent_uuid: "6ccc508628554c988adee1ef348e2fe3" member_type: VOTER last_known_addr { host: "127.12.2.1" port: 42723 } }
20:04:18.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.992938 13056 raft_consensus.cc:385] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:04:18.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.993872 13056 raft_consensus.cc:740] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6ccc508628554c988adee1ef348e2fe3, State: Initialized, Role: FOLLOWER
20:04:18.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:18.996255 13056 consensus_queue.cc:260] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [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: "5859d48a6c344a839195e24d4fe113b5" member_type: VOTER last_known_addr { host: "127.12.2.2" port: 37789 } } peers { permanent_uuid: "d86950dd911048da9de737ee58d8c90a" member_type: VOTER last_known_addr { host: "127.12.2.3" port: 44461 } } peers { permanent_uuid: "6ccc508628554c988adee1ef348e2fe3" member_type: VOTER last_known_addr { host: "127.12.2.1" port: 42723 } }
20:04:19.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.004500 13058 tablet_bootstrap.cc:654] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5: Neither blocks nor log segments found. Creating new log.
20:04:19.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.010872 13058 log.cc:826] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5: Log is configured to *not* fsync() on all Append() calls
20:04:19.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.017599 13056 ts_tablet_manager.cc:1434] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3: Time spent starting tablet: real 0.068s	user 0.033s	sys 0.030s
20:04:19.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.017860 13055 tablet_bootstrap.cc:492] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a: No bootstrap required, opened a new log
20:04:19.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.018533 13055 ts_tablet_manager.cc:1403] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a: Time spent bootstrapping tablet: real 0.061s	user 0.024s	sys 0.015s
20:04:19.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.025033 13058 tablet_bootstrap.cc:492] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5: No bootstrap required, opened a new log
20:04:19.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.025970 13058 ts_tablet_manager.cc:1403] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5: Time spent bootstrapping tablet: real 0.044s	user 0.013s	sys 0.019s
20:04:19.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.067756 13055 raft_consensus.cc:359] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5859d48a6c344a839195e24d4fe113b5" member_type: VOTER last_known_addr { host: "127.12.2.2" port: 37789 } } peers { permanent_uuid: "d86950dd911048da9de737ee58d8c90a" member_type: VOTER last_known_addr { host: "127.12.2.3" port: 44461 } } peers { permanent_uuid: "6ccc508628554c988adee1ef348e2fe3" member_type: VOTER last_known_addr { host: "127.12.2.1" port: 42723 } }
20:04:19.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.067780 13058 raft_consensus.cc:359] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5859d48a6c344a839195e24d4fe113b5" member_type: VOTER last_known_addr { host: "127.12.2.2" port: 37789 } } peers { permanent_uuid: "d86950dd911048da9de737ee58d8c90a" member_type: VOTER last_known_addr { host: "127.12.2.3" port: 44461 } } peers { permanent_uuid: "6ccc508628554c988adee1ef348e2fe3" member_type: VOTER last_known_addr { host: "127.12.2.1" port: 42723 } }
20:04:19.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.068943 13055 raft_consensus.cc:385] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:04:19.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.069402 13055 raft_consensus.cc:740] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: d86950dd911048da9de737ee58d8c90a, State: Initialized, Role: FOLLOWER
20:04:19.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.070276 13058 raft_consensus.cc:385] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:04:19.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.070869 13058 raft_consensus.cc:740] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 5859d48a6c344a839195e24d4fe113b5, State: Initialized, Role: FOLLOWER
20:04:19.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.070706 13055 consensus_queue.cc:260] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a [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: "5859d48a6c344a839195e24d4fe113b5" member_type: VOTER last_known_addr { host: "127.12.2.2" port: 37789 } } peers { permanent_uuid: "d86950dd911048da9de737ee58d8c90a" member_type: VOTER last_known_addr { host: "127.12.2.3" port: 44461 } } peers { permanent_uuid: "6ccc508628554c988adee1ef348e2fe3" member_type: VOTER last_known_addr { host: "127.12.2.1" port: 42723 } }
20:04:19.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.072599 13058 consensus_queue.cc:260] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5 [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: "5859d48a6c344a839195e24d4fe113b5" member_type: VOTER last_known_addr { host: "127.12.2.2" port: 37789 } } peers { permanent_uuid: "d86950dd911048da9de737ee58d8c90a" member_type: VOTER last_known_addr { host: "127.12.2.3" port: 44461 } } peers { permanent_uuid: "6ccc508628554c988adee1ef348e2fe3" member_type: VOTER last_known_addr { host: "127.12.2.1" port: 42723 } }
20:04:19.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.082949 13055 ts_tablet_manager.cc:1434] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a: Time spent starting tablet: real 0.064s	user 0.044s	sys 0.010s
20:04:19.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.093212 13058 ts_tablet_manager.cc:1434] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5: Time spent starting tablet: real 0.067s	user 0.025s	sys 0.037s
20:04:19.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:19.111759 12886 tablet.cc:2404] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:04:19.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:19.232720 12744 tablet.cc:2404] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:04:19.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 20:04:19.258634 13027 tablet.cc:2404] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:04:19.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.279882 13060 raft_consensus.cc:493] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
20:04:19.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.280349 13060 raft_consensus.cc:515] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5859d48a6c344a839195e24d4fe113b5" member_type: VOTER last_known_addr { host: "127.12.2.2" port: 37789 } } peers { permanent_uuid: "d86950dd911048da9de737ee58d8c90a" member_type: VOTER last_known_addr { host: "127.12.2.3" port: 44461 } } peers { permanent_uuid: "6ccc508628554c988adee1ef348e2fe3" member_type: VOTER last_known_addr { host: "127.12.2.1" port: 42723 } }
20:04:19.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.283558 13060 leader_election.cc:290] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 5859d48a6c344a839195e24d4fe113b5 (127.12.2.2:37789), d86950dd911048da9de737ee58d8c90a (127.12.2.3:44461)
20:04:19.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.300331 12832 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b731cb7146ce4627861654ce3d86847a" candidate_uuid: "6ccc508628554c988adee1ef348e2fe3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5859d48a6c344a839195e24d4fe113b5" is_pre_election: true
20:04:19.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.301281 12973 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b731cb7146ce4627861654ce3d86847a" candidate_uuid: "6ccc508628554c988adee1ef348e2fe3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "d86950dd911048da9de737ee58d8c90a" is_pre_election: true
20:04:19.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.301697 12832 raft_consensus.cc:2468] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 6ccc508628554c988adee1ef348e2fe3 in term 0.
20:04:19.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.302508 12973 raft_consensus.cc:2468] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 6ccc508628554c988adee1ef348e2fe3 in term 0.
20:04:19.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.303453 12623 leader_election.cc:304] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [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: 5859d48a6c344a839195e24d4fe113b5, 6ccc508628554c988adee1ef348e2fe3; no voters: 
20:04:19.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.304735 13060 raft_consensus.cc:2804] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [term 0 FOLLOWER]: Leader pre-election won for term 1
20:04:19.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.305303 13060 raft_consensus.cc:493] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
20:04:19.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.305791 13060 raft_consensus.cc:3060] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [term 0 FOLLOWER]: Advancing to term 1
20:04:19.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.314841 13060 raft_consensus.cc:515] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5859d48a6c344a839195e24d4fe113b5" member_type: VOTER last_known_addr { host: "127.12.2.2" port: 37789 } } peers { permanent_uuid: "d86950dd911048da9de737ee58d8c90a" member_type: VOTER last_known_addr { host: "127.12.2.3" port: 44461 } } peers { permanent_uuid: "6ccc508628554c988adee1ef348e2fe3" member_type: VOTER last_known_addr { host: "127.12.2.1" port: 42723 } }
20:04:19.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.316797 13060 leader_election.cc:290] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [CANDIDATE]: Term 1 election: Requested vote from peers 5859d48a6c344a839195e24d4fe113b5 (127.12.2.2:37789), d86950dd911048da9de737ee58d8c90a (127.12.2.3:44461)
20:04:19.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.317752 12832 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b731cb7146ce4627861654ce3d86847a" candidate_uuid: "6ccc508628554c988adee1ef348e2fe3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5859d48a6c344a839195e24d4fe113b5"
20:04:19.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.317960 12973 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b731cb7146ce4627861654ce3d86847a" candidate_uuid: "6ccc508628554c988adee1ef348e2fe3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "d86950dd911048da9de737ee58d8c90a"
20:04:19.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.318245 12832 raft_consensus.cc:3060] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5 [term 0 FOLLOWER]: Advancing to term 1
20:04:19.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.318341 12973 raft_consensus.cc:3060] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a [term 0 FOLLOWER]: Advancing to term 1
20:04:19.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.323688 12832 raft_consensus.cc:2468] T b731cb7146ce4627861654ce3d86847a P 5859d48a6c344a839195e24d4fe113b5 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 6ccc508628554c988adee1ef348e2fe3 in term 1.
20:04:19.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.324950 12623 leader_election.cc:304] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [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: 5859d48a6c344a839195e24d4fe113b5, 6ccc508628554c988adee1ef348e2fe3; no voters: 
20:04:19.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.326053 13060 raft_consensus.cc:2804] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [term 1 FOLLOWER]: Leader election won for term 1
20:04:19.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.326721 12973 raft_consensus.cc:2468] T b731cb7146ce4627861654ce3d86847a P d86950dd911048da9de737ee58d8c90a [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 6ccc508628554c988adee1ef348e2fe3 in term 1.
20:04:19.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.330307 13060 raft_consensus.cc:697] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [term 1 LEADER]: Becoming Leader. State: Replica: 6ccc508628554c988adee1ef348e2fe3, State: Running, Role: LEADER
20:04:19.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.331269 13060 consensus_queue.cc:237] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [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: "5859d48a6c344a839195e24d4fe113b5" member_type: VOTER last_known_addr { host: "127.12.2.2" port: 37789 } } peers { permanent_uuid: "d86950dd911048da9de737ee58d8c90a" member_type: VOTER last_known_addr { host: "127.12.2.3" port: 44461 } } peers { permanent_uuid: "6ccc508628554c988adee1ef348e2fe3" member_type: VOTER last_known_addr { host: "127.12.2.1" port: 42723 } }
20:04:19.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.345077 12497 catalog_manager.cc:5696] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 reported cstate change: term changed from 0 to 1, leader changed from <none> to 6ccc508628554c988adee1ef348e2fe3 (127.12.2.1). New cstate: current_term: 1 leader_uuid: "6ccc508628554c988adee1ef348e2fe3" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5859d48a6c344a839195e24d4fe113b5" member_type: VOTER last_known_addr { host: "127.12.2.2" port: 37789 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "d86950dd911048da9de737ee58d8c90a" member_type: VOTER last_known_addr { host: "127.12.2.3" port: 44461 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "6ccc508628554c988adee1ef348e2fe3" member_type: VOTER last_known_addr { host: "127.12.2.1" port: 42723 } health_report { overall_health: HEALTHY } } }
20:04:19.712 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet b731cb7146ce4627861654ce3d86847a for table 'org.apache.kudu.client.TestHybridTime-1779134637211' with partition [<start>, <end>)
20:04:19.720 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299991, tablet=b731cb7146ce4627861654ce3d86847a@[5859d48a6c344a839195e24d4fe113b5(127.12.2.2:37789),6ccc508628554c988adee1ef348e2fe3(127.12.2.1:42723)[L],d86950dd911048da9de737ee58d8c90a(127.12.2.3:44461)]}]
20:04:19.722 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=24), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.12.2.60:40835, [11ms] Sub RPC GetTableLocations: received response from server master-127.12.2.60:40835: OK, deferred=null) after lookup
20:04:19.734 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 6ccc508628554c988adee1ef348e2fe3(127.12.2.1:42723)] connecting to peer
20:04:19.737 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 6ccc508628554c988adee1ef348e2fe3(127.12.2.1:42723)] Successfully connected to peer
20:04:19.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.807392 13060 consensus_queue.cc:1048] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [LEADER]: Connected to new peer: Peer: permanent_uuid: "d86950dd911048da9de737ee58d8c90a" member_type: VOTER last_known_addr { host: "127.12.2.3" port: 44461 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
20:04:19.832 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x7bcb9534, L:/127.0.0.1:36032 - R:/127.12.2.1:42723] using TOKEN/null
20:04:19.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:19.859467 13060 consensus_queue.cc:1048] T b731cb7146ce4627861654ce3d86847a P 6ccc508628554c988adee1ef348e2fe3 [LEADER]: Connected to new peer: Peer: permanent_uuid: "5859d48a6c344a839195e24d4fe113b5" member_type: VOTER last_known_addr { host: "127.12.2.2" port: 37789 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
20:04:20.046 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:04:20.080 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:04:20.109 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:04:20.119 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1386150007(state=PENDING, result=null, callback=<none>, errback=<none>)}
20:04:20.154 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:04:20.155 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1988640191(state=PENDING, result=null, callback=<none>, errback=<none>)}
20:04:20.177 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:04:20.177 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1351306392(state=PENDING, result=null, callback=<none>, errback=<none>)}
20:04:20.193 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:04:20.256 [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-1779134637211, tablet=b731cb7146ce4627861654ce3d86847a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:04:20.273 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7287335587264311297) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779134637211, tablet=b731cb7146ce4627861654ce3d86847a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:04:20.289 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7287335587264311303) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779134637211, tablet=b731cb7146ce4627861654ce3d86847a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:04:20.302 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7287335587264311307) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779134637211, tablet=b731cb7146ce4627861654ce3d86847a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:04:20.312 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7287335587264311311) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779134637211, tablet=b731cb7146ce4627861654ce3d86847a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:04:20.321 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7287335587264311316) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779134637211, tablet=b731cb7146ce4627861654ce3d86847a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:04:20.329 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7287335587264311320) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779134637211, tablet=b731cb7146ce4627861654ce3d86847a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:04:20.337 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7287335587264311321) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779134637211, tablet=b731cb7146ce4627861654ce3d86847a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:04:20.345 [DEBUG - main] (Connection.java:575) [peer master-127.12.2.60:40835(127.12.2.60:40835)] disconnecting while in state READY
20:04:20.346 [DEBUG - main] (Connection.java:575) [peer 6ccc508628554c988adee1ef348e2fe3(127.12.2.1:42723)] disconnecting while in state READY
20:04:20.346 [DEBUG - main] (Connection.java:575) [peer master-127.12.2.62:43383(127.12.2.62:43383)] disconnecting while in state READY
20:04:20.346 [DEBUG - main] (Connection.java:575) [peer master-127.12.2.61:45125(127.12.2.61:45125)] disconnecting while in state READY
20:04:20.351 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.12.2.60:40835(127.12.2.60:40835)] handling channelInactive
20:04:20.351 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.12.2.62:43383(127.12.2.62:43383)] handling channelInactive
20:04:20.351 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.12.2.60:40835(127.12.2.60:40835)] cleaning up while in state READY due to: connection closed
20:04:20.351 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.12.2.62:43383(127.12.2.62:43383)] cleaning up while in state READY due to: connection closed
20:04:20.352 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.12.2.61:45125(127.12.2.61:45125)] handling channelInactive
20:04:20.352 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.12.2.61:45125(127.12.2.61:45125)] cleaning up while in state READY due to: connection closed
20:04:20.353 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
20:04:20.361 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 6ccc508628554c988adee1ef348e2fe3(127.12.2.1:42723)] handling channelInactive
20:04:20.361 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 6ccc508628554c988adee1ef348e2fe3(127.12.2.1:42723)] cleaning up while in state READY due to: connection closed
20:04:20.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:20.362519 12296 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu with pid 12577
20:04:20.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:20.397236 12296 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu with pid 12745
20:04:20.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:20.423774 12296 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu with pid 12887
20:04:20.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:20.452327 12296 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu with pid 12308
20:04:20.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:20.477090 12296 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu with pid 12378
20:04:20.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 20:04:20.502545 12296 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskSYXuPB/build/tsan/bin/kudu with pid 12453
20:04:20.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T20:04:20Z chronyd exiting

Time: 24.528

OK (1 test)

