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

14:04:23.467 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:04:23.468 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

14:04:23.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:23.472151 17871 mini_oidc.cc:150] Starting JWKS server
14:04:23.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:23.475706 17871 webserver.cc:533] Webserver started at http://127.0.0.1:44621/ using document root <none> and password file <none>
14:04:23.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:23.476254 17871 mini_oidc.cc:186] Starting OIDC Discovery server
14:04:23.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:23.479552 17871 webserver.cc:533] Webserver started at http://127.0.0.1:39521/ using document root <none> and password file <none>
14:04:23.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:04:23Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
14:04:23.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:04:23Z Disabled control of system clock
14:04:23.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:23.542186 17871 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:23.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:23.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/wal
14:04:23.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/data
14:04:23.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:04:23.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:04:23.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:04:23.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:23.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:23.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:23.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/logs
14:04:23.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/data/info.pb
14:04:23.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:23.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:04:23.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:04:23.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:04:23.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:04:23.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:23.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:23.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:23.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:04:23.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:04:23.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:04:23.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:04:23.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.254:39909
14:04:23.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.254
14:04:23.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:23.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:23.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:23.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:23.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:04:23.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:04:23.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:23.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:04:23.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44621/jwks.json with env {}
14:04:23.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:23.849782 17884 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:04:23.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:23.850332 17884 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:04:23.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:23.851032 17884 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:04:23.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:23.884594 17884 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:04:23.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:23.884888 17884 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:04:23.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:23.885084 17884 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:04:23.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:23.885385 17884 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:04:23.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:23.885697 17884 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:04:23.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:23.885958 17884 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:44621/jwks.json
14:04:23.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:23.924045 17884 master_runner.cc:387] Master server non-default flags:
14:04:23.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:23.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:23.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:23.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:04:23.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/data
14:04:23.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/wal
14:04:23.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:04:23.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:23.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:23.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:23.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:04:23.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.254:39909
14:04:23.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:04:23.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:04:23.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:04:23.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44621/jwks.json
14:04:23.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:23.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:23.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/data/info.pb
14:04:23.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.254
14:04:23.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:23.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:04:23.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:23.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:04:23.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:04:23.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:23.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/logs
14:04:23.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:23.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:04:23.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:04:23.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:04:23.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:04:23.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:04:23.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:04:23.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:22 UTC on e7f111948823
14:04:23.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11959
14:04:23.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:04:23.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:23.925365 17884 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:04:23.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:23.927412 17884 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:04:23.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:23.941231 17890 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:25.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:23.941244 17891 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:25.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.165262 17893 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:25.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.168040 17892 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1220 milliseconds
14:04:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.168017 17884 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.227s	user 0.403s	sys 0.824s
14:04:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.168449 17884 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.228s	user 0.403s	sys 0.824s
14:04:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.168774 17884 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
14:04:25.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.170253 17884 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:04:25.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.173655 17884 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:04:25.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.175693 17884 hybrid_clock.cc:648] HybridClock initialized: now 1779113065175641 us; error 47 us; skew 500 ppm
14:04:25.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.176925 17884 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:04:25.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.186353 17884 webserver.cc:533] Webserver started at http://127.17.115.254:38581/ using document root <none> and password file <none>
14:04:25.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.187852 17884 fs_manager.cc:362] Metadata directory not provided
14:04:25.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.188197 17884 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:04:25.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.188777 17884 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:04:25.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.196360 17884 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/data/instance:
14:04:25.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "92e9acb8ad794e89b3811e0ca67e58d3"
14:04:25.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:25 on dist-test-slave-jqdf"
14:04:25.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.197932 17884 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/wal/instance:
14:04:25.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "92e9acb8ad794e89b3811e0ca67e58d3"
14:04:25.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:25 on dist-test-slave-jqdf"
14:04:25.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.221571 17884 fs_manager.cc:696] Time spent creating directory manager: real 0.023s	user 0.014s	sys 0.010s
14:04:25.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.228091 17900 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:04:25.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.229311 17884 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.003s	sys 0.001s
14:04:25.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.229620 17884 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/data,/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/wal
14:04:25.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "92e9acb8ad794e89b3811e0ca67e58d3"
14:04:25.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:25 on dist-test-slave-jqdf"
14:04:25.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.229996 17884 fs_report.cc:389] FS layout report
14:04:25.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:04:25.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/wal
14:04:25.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/wal
14:04:25.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/data/data
14:04:25.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:04:25.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:04:25.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:04:25.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:04:25.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:04:25.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:04:25.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:04:25.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:04:25.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:04:25.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:04:25.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:04:25.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.301246 17884 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:04:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.303212 17884 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
14:04:25.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.303792 17884 kserver.cc:163] Server-wide thread pool size limit: 3276
14:04:25.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.373715 17884 rpc_server.cc:307] RPC server started. Bound to: 127.17.115.254:39909
14:04:25.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.373807 17951 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.115.254:39909 every 8 connection(s)
14:04:25.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.376462 17884 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/data/info.pb
14:04:25.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.382014 17952 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:04:25.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.387251 17871 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu as pid 17884
14:04:25.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.387602 17871 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-0/wal/instance
14:04:25.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.390862 17871 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:25.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:25.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/wal
14:04:25.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/data
14:04:25.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:04:25.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:04:25.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:04:25.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:25.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:25.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:25.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/logs
14:04:25.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/data/info.pb
14:04:25.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:25.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:04:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:04:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:04:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:04:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:25.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:04:25.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:04:25.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:04:25.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:04:25.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.253:42199
14:04:25.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.253
14:04:25.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:25.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:25.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:25.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:25.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:04:25.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:04:25.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:25.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:04:25.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44621/jwks.json with env {}
14:04:25.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.393586 17952 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } has no permanent_uuid. Determining permanent_uuid...
14:04:25.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.421052 17952 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } has no permanent_uuid. Determining permanent_uuid...
14:04:25.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.423493 17902 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.17.115.253:42199: connect: Connection refused (error 111)
14:04:25.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.427891 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.253:42199: Network error: Client connection negotiation failed: client connection to 127.17.115.253:42199: connect: Connection refused (error 111)
14:04:25.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.477458 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } attempt: 1
14:04:25.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.481627 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.253:42199: Network error: Client connection negotiation failed: client connection to 127.17.115.253:42199: connect: Connection refused (error 111)
14:04:25.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.550146 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } attempt: 2
14:04:25.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.554276 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.253:42199: Network error: Client connection negotiation failed: client connection to 127.17.115.253:42199: connect: Connection refused (error 111)
14:04:25.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.645766 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } attempt: 3
14:04:25.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.649753 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.253:42199: Network error: Client connection negotiation failed: client connection to 127.17.115.253:42199: connect: Connection refused (error 111)
14:04:25.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.700513 17954 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:04:25.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.701053 17954 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:04:25.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.701475 17954 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:04:25.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.734148 17954 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:04:25.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.734429 17954 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:04:25.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.734623 17954 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:04:25.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.734814 17954 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:04:25.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.735085 17954 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:04:25.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.735328 17954 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:44621/jwks.json
14:04:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.782233 17954 master_runner.cc:387] Master server non-default flags:
14:04:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:04:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/data
14:04:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/wal
14:04:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:04:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:04:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.253:42199
14:04:25.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:04:25.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:04:25.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:04:25.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44621/jwks.json
14:04:25.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:25.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:25.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/data/info.pb
14:04:25.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.253
14:04:25.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:25.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:04:25.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:25.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:04:25.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:04:25.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:25.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/logs
14:04:25.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:25.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:04:25.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:04:25.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:04:25.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:04:25.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:04:25.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:04:25.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:22 UTC on e7f111948823
14:04:25.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11959
14:04:25.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:04:25.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.783663 17954 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:04:25.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.785365 17954 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:04:25.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:25.793241 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } attempt: 4
14:04:25.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.798236 17963 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:25.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.799327 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.253:42199: Network error: Client connection negotiation failed: client connection to 127.17.115.253:42199: connect: Connection refused (error 111)
14:04:26.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:26.098840 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } attempt: 5
14:04:26.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:26.107947 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.253:42199: Network error: Client connection negotiation failed: client connection to 127.17.115.253:42199: connect: Connection refused (error 111)
14:04:26.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:26.655556 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } attempt: 6
14:04:26.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:26.683756 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.253:42199: Network error: Client connection negotiation failed: client connection to 127.17.115.253:42199: connect: Connection refused (error 111)
14:04:27.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.203649 17962 debug-util.cc:398] Leaking SignalData structure 0x7b08000271e0 after lost signal to thread 17954
14:04:27.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.354684 17954 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.554s	user 0.611s	sys 0.939s
14:04:27.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.355213 17954 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.554s	user 0.611s	sys 0.939s
14:04:27.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:25.800990 17964 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:27.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.358222 17966 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:27.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.363682 17965 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1562 milliseconds
14:04:27.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.363786 17954 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
14:04:27.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.365270 17954 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:04:27.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.368140 17954 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:04:27.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.369518 17954 hybrid_clock.cc:648] HybridClock initialized: now 1779113067369481 us; error 85 us; skew 500 ppm
14:04:27.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.370313 17954 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:04:27.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.378432 17954 webserver.cc:533] Webserver started at http://127.17.115.253:33617/ using document root <none> and password file <none>
14:04:27.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.379853 17954 fs_manager.cc:362] Metadata directory not provided
14:04:27.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.380167 17954 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:04:27.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.380762 17954 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:04:27.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.387566 17954 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/data/instance:
14:04:27.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "802a52d988b64abba97fb5b231c55815"
14:04:27.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:27 on dist-test-slave-jqdf"
14:04:27.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.388875 17954 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/wal/instance:
14:04:27.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "802a52d988b64abba97fb5b231c55815"
14:04:27.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:27 on dist-test-slave-jqdf"
14:04:27.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.396715 17954 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.004s	sys 0.004s
14:04:27.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.402661 17975 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:04:27.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.403966 17954 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.001s
14:04:27.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.404351 17954 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/data,/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/wal
14:04:27.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "802a52d988b64abba97fb5b231c55815"
14:04:27.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:27 on dist-test-slave-jqdf"
14:04:27.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.404814 17954 fs_report.cc:389] FS layout report
14:04:27.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:04:27.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/wal
14:04:27.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/wal
14:04:27.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/data/data
14:04:27.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:04:27.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:04:27.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:04:27.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:04:27.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:04:27.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:04:27.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:04:27.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:04:27.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:04:27.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:04:27.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:04:27.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.459708 17954 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:04:27.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.461484 17954 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
14:04:27.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.462010 17954 kserver.cc:163] Server-wide thread pool size limit: 3276
14:04:27.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.534198 17954 rpc_server.cc:307] RPC server started. Bound to: 127.17.115.253:42199
14:04:27.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.534279 18026 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.115.253:42199 every 8 connection(s)
14:04:27.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.537274 17954 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/data/info.pb
14:04:27.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.539698 17871 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu as pid 17954
14:04:27.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.540215 17871 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-1/wal/instance
14:04:27.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.542647 17871 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:27.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:27.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/wal
14:04:27.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/data
14:04:27.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:04:27.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:04:27.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:04:27.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:27.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:27.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:27.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/logs
14:04:27.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/data/info.pb
14:04:27.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:27.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:04:27.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:04:27.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:04:27.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:04:27.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:27.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:27.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:27.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:04:27.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:04:27.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:04:27.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:04:27.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.252:39251
14:04:27.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.252
14:04:27.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:27.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:27.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:27.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:27.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:04:27.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:04:27.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:27.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:04:27.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44621/jwks.json with env {}
14:04:27.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.544396 18027 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:04:27.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.556733 18027 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } has no permanent_uuid. Determining permanent_uuid...
14:04:27.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.578200 18027 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } has no permanent_uuid. Determining permanent_uuid...
14:04:27.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.592803 18027 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } has no permanent_uuid. Determining permanent_uuid...
14:04:27.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.595825 17979 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:27.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.600003 18027 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:27.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.649569 18027 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 1
14:04:27.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.654196 18027 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:27.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.722563 18027 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 2
14:04:27.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.726303 18027 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:27.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.744345 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } attempt: 7
14:04:27.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.760116 17952 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } has no permanent_uuid. Determining permanent_uuid...
14:04:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.766320 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:27.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.817811 18027 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 3
14:04:27.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.822041 18027 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:27.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.824797 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 1
14:04:27.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.828699 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:27.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.866608 18029 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:04:27.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.867291 18029 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:04:27.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.868006 18029 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:04:27.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.900990 18029 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:04:27.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.901376 18029 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:04:27.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.901714 18029 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:04:27.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.902060 18029 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:04:27.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.902424 18029 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:04:27.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.902696 18029 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:44621/jwks.json
14:04:27.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.910220 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 2
14:04:27.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.914151 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:27.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.940708 18029 master_runner.cc:387] Master server non-default flags:
14:04:27.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:27.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:27.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:27.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:04:27.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/data
14:04:27.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/wal
14:04:27.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:04:27.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:27.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:27.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:27.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:04:27.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.252:39251
14:04:27.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:04:27.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:04:27.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:04:27.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44621/jwks.json
14:04:27.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:27.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:27.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/data/info.pb
14:04:27.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.252
14:04:27.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:27.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:04:27.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:27.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/logs
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:22 UTC on e7f111948823
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11959
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.942292 18029 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:04:27.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.944583 18029 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:04:27.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.957226 18041 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:27.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.965421 18027 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 4
14:04:27.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.971138 18027 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:28.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:27.999606 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 3
14:04:28.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:28.008452 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:28.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:28.164006 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 4
14:04:28.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:28.179239 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:28.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:28.270618 18027 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 5
14:04:28.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:28.279182 18027 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:28.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:28.462867 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 5
14:04:28.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:28.471989 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:28.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:28.826781 18027 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 6
14:04:28.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:28.854497 18027 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:29.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.024614 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 6
14:04:29.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:29.048954 17952 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.115.252:39251: Network error: Client connection negotiation failed: client connection to 127.17.115.252:39251: connect: Connection refused (error 111)
14:04:29.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:29.383109 18040 debug-util.cc:398] Leaking SignalData structure 0x7b08000271e0 after lost signal to thread 18029
14:04:29.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:27.957737 18042 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:29.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:29.524550 18029 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.568s	user 0.605s	sys 0.952s
14:04:29.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:29.524945 18029 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.568s	user 0.605s	sys 0.952s
14:04:29.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:29.527228 18044 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:29.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:29.530946 18043 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1570 milliseconds
14:04:29.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.530970 18029 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
14:04:29.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.532344 18029 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:04:29.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.536371 18029 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:04:29.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.537783 18029 hybrid_clock.cc:648] HybridClock initialized: now 1779113069537736 us; error 65 us; skew 500 ppm
14:04:29.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.538689 18029 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:04:29.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.545230 18029 webserver.cc:533] Webserver started at http://127.17.115.252:46117/ using document root <none> and password file <none>
14:04:29.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.546258 18029 fs_manager.cc:362] Metadata directory not provided
14:04:29.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.546499 18029 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:04:29.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.547092 18029 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:04:29.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.552050 18029 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/data/instance:
14:04:29.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "34d8e25d9d9d470282af4c999de8e327"
14:04:29.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:29 on dist-test-slave-jqdf"
14:04:29.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.553467 18029 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/wal/instance:
14:04:29.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "34d8e25d9d9d470282af4c999de8e327"
14:04:29.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:29 on dist-test-slave-jqdf"
14:04:29.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.561353 18029 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.009s	sys 0.001s
14:04:29.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.567440 18055 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:04:29.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.568629 18029 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.004s	sys 0.000s
14:04:29.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.568977 18029 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/data,/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/wal
14:04:29.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "34d8e25d9d9d470282af4c999de8e327"
14:04:29.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:29 on dist-test-slave-jqdf"
14:04:29.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.569394 18029 fs_report.cc:389] FS layout report
14:04:29.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:04:29.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/wal
14:04:29.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/wal
14:04:29.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/data/data
14:04:29.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:04:29.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:04:29.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:04:29.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:04:29.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:04:29.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:04:29.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:04:29.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:04:29.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:04:29.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:04:29.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:04:29.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.627800 18029 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:04:29.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.629437 18029 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
14:04:29.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.629983 18029 kserver.cc:163] Server-wide thread pool size limit: 3276
14:04:29.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.701730 18029 rpc_server.cc:307] RPC server started. Bound to: 127.17.115.252:39251
14:04:29.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.701836 18106 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.115.252:39251 every 8 connection(s)
14:04:29.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.704579 18029 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/data/info.pb
14:04:29.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.705775 17871 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu as pid 18029
14:04:29.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.706300 17871 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/master-2/wal/instance
14:04:29.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.711895 18107 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:04:29.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.732903 18107 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } has no permanent_uuid. Determining permanent_uuid...
14:04:29.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.756618 18107 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } has no permanent_uuid. Determining permanent_uuid...
14:04:29.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.765806 18107 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } has no permanent_uuid. Determining permanent_uuid...
14:04:29.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.782783 18107 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327: Bootstrap starting.
14:04:29.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.789670 18107 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327: Neither blocks nor log segments found. Creating new log.
14:04:29.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.791611 18107 log.cc:826] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327: Log is configured to *not* fsync() on all Append() calls
14:04:29.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.796195 18107 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327: No bootstrap required, opened a new log
14:04:29.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.816603 18107 raft_consensus.cc:359] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } }
14:04:29.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.817286 18107 raft_consensus.cc:385] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:04:29.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.817488 18107 raft_consensus.cc:740] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 34d8e25d9d9d470282af4c999de8e327, State: Initialized, Role: FOLLOWER
14:04:29.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.818300 18107 consensus_queue.cc:260] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [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: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } }
14:04:29.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.821138 18115 sys_catalog.cc:455] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [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: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } } }
14:04:29.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.822721 18115 sys_catalog.cc:458] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [sys.catalog]: This master's current role is: FOLLOWER
14:04:29.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.823077 18107 sys_catalog.cc:565] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [sys.catalog]: configured and running, proceeding with master startup.
14:04:29.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:29.847280 18126 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:04:29.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:29.847661 18126 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:04:29.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.843453 18029 master_runner.cc:187] Error getting master registration for 127.17.115.254:39909: OK, instance_id { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" instance_seqno: 1779113065355275 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:04:29.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.865767 18029 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:04:29.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:29.885424 18061 tablet.cc:2404] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:04:29.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.915035 18027 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 7
14:04:29.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.933817 18027 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815: Bootstrap starting.
14:04:29.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.940552 18027 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815: Neither blocks nor log segments found. Creating new log.
14:04:29.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.943820 18027 log.cc:826] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815: Log is configured to *not* fsync() on all Append() calls
14:04:29.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.951294 18027 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815: No bootstrap required, opened a new log
14:04:29.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.969314 18027 raft_consensus.cc:359] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } }
14:04:29.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.970062 18027 raft_consensus.cc:385] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:04:29.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.970348 18027 raft_consensus.cc:740] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 802a52d988b64abba97fb5b231c55815, State: Initialized, Role: FOLLOWER
14:04:29.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.971271 18027 consensus_queue.cc:260] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [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: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } }
14:04:29.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.974080 18130 sys_catalog.cc:455] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [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: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } } }
14:04:29.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.975312 18130 sys_catalog.cc:458] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [sys.catalog]: This master's current role is: FOLLOWER
14:04:29.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:29.976097 18027 sys_catalog.cc:565] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [sys.catalog]: configured and running, proceeding with master startup.
14:04:30.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:30.007612 18141 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:04:30.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:30.008550 18141 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:04:30.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.002627 17954 master_runner.cc:187] Error getting master registration for 127.17.115.254:39909: OK, instance_id { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" instance_seqno: 1779113065355275 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:04:30.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.037104 17954 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:04:30.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.073624 18115 raft_consensus.cc:493] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:04:30.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.074165 18115 raft_consensus.cc:515] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } }
14:04:30.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.076632 18115 leader_election.cc:290] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 92e9acb8ad794e89b3811e0ca67e58d3 (127.17.115.254:39909), 802a52d988b64abba97fb5b231c55815 (127.17.115.253:42199)
14:04:30.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.079136 18002 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "34d8e25d9d9d470282af4c999de8e327" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "802a52d988b64abba97fb5b231c55815" is_pre_election: true
14:04:30.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.080037 18002 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 34d8e25d9d9d470282af4c999de8e327 in term 0.
14:04:30.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.081516 18057 leader_election.cc:304] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [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: 34d8e25d9d9d470282af4c999de8e327, 802a52d988b64abba97fb5b231c55815; no voters: 
14:04:30.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.082455 17952 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } attempt: 7
14:04:30.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.084841 18115 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [term 0 FOLLOWER]: Leader pre-election won for term 1
14:04:30.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.085196 18115 raft_consensus.cc:493] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:04:30.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.085512 18115 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [term 0 FOLLOWER]: Advancing to term 1
14:04:30.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.112677 18115 raft_consensus.cc:515] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } }
14:04:30.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.116235 17952 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3: Bootstrap starting.
14:04:30.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.125330 17952 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3: Neither blocks nor log segments found. Creating new log.
14:04:30.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.128186 17952 log.cc:826] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3: Log is configured to *not* fsync() on all Append() calls
14:04:30.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.131305 18002 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "34d8e25d9d9d470282af4c999de8e327" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "802a52d988b64abba97fb5b231c55815"
14:04:30.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.131922 18002 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [term 0 FOLLOWER]: Advancing to term 1
14:04:30.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.140882 18002 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 34d8e25d9d9d470282af4c999de8e327 in term 1.
14:04:30.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.144325 18057 leader_election.cc:304] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [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: 34d8e25d9d9d470282af4c999de8e327, 802a52d988b64abba97fb5b231c55815; no voters: 
14:04:30.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.142768 18115 leader_election.cc:290] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [CANDIDATE]: Term 1 election: Requested vote from peers 92e9acb8ad794e89b3811e0ca67e58d3 (127.17.115.254:39909), 802a52d988b64abba97fb5b231c55815 (127.17.115.253:42199)
14:04:30.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.146611 18145 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [term 1 FOLLOWER]: Leader election won for term 1
14:04:30.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.148203 18145 raft_consensus.cc:697] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [term 1 LEADER]: Becoming Leader. State: Replica: 34d8e25d9d9d470282af4c999de8e327, State: Running, Role: LEADER
14:04:30.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.149412 18145 consensus_queue.cc:237] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [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: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } }
14:04:30.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.150676 17952 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3: No bootstrap required, opened a new log
14:04:30.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.173942 18115 sys_catalog.cc:455] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 34d8e25d9d9d470282af4c999de8e327. Latest consensus state: current_term: 1 leader_uuid: "34d8e25d9d9d470282af4c999de8e327" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } } }
14:04:30.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.174662 18115 sys_catalog.cc:458] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [sys.catalog]: This master's current role is: LEADER
14:04:30.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.180155 17952 raft_consensus.cc:359] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } }
14:04:30.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.184005 17952 raft_consensus.cc:385] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:04:30.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.185032 17952 raft_consensus.cc:740] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 92e9acb8ad794e89b3811e0ca67e58d3, State: Initialized, Role: FOLLOWER
14:04:30.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.186551 17952 consensus_queue.cc:260] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [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: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } }
14:04:30.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.188205 18147 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
14:04:30.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.195470 18147 catalog_manager.cc:1519] Initializing Kudu cluster ID...
14:04:30.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.195166 18148 sys_catalog.cc:455] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [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: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } } }
14:04:30.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.195999 18148 sys_catalog.cc:458] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [sys.catalog]: This master's current role is: FOLLOWER
14:04:30.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.199103 17952 sys_catalog.cc:565] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [sys.catalog]: configured and running, proceeding with master startup.
14:04:30.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.199265 17927 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "34d8e25d9d9d470282af4c999de8e327" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" is_pre_election: true
14:04:30.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.199998 17926 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "34d8e25d9d9d470282af4c999de8e327" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "92e9acb8ad794e89b3811e0ca67e58d3"
14:04:30.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.200299 17927 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 34d8e25d9d9d470282af4c999de8e327 in term 0.
14:04:30.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:30.221244 17981 tablet.cc:2404] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:04:30.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.226498 18002 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [term 1 FOLLOWER]: Refusing update from remote peer 34d8e25d9d9d470282af4c999de8e327: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:04:30.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.228850 18115 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [LEADER]: Connected to new peer: Peer: permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:04:30.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.237183 17927 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [term 0 FOLLOWER]: Advancing to term 1
14:04:30.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.250836 17927 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [term 1 FOLLOWER]: Refusing update from remote peer 34d8e25d9d9d470282af4c999de8e327: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:04:30.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.252993 18115 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [LEADER]: Connected to new peer: Peer: permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:04:30.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.285181 18130 sys_catalog.cc:455] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 34d8e25d9d9d470282af4c999de8e327. Latest consensus state: current_term: 1 leader_uuid: "34d8e25d9d9d470282af4c999de8e327" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } } }
14:04:30.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.286182 18130 sys_catalog.cc:458] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [sys.catalog]: This master's current role is: FOLLOWER
14:04:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.288515 18148 sys_catalog.cc:455] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 34d8e25d9d9d470282af4c999de8e327. Latest consensus state: current_term: 1 leader_uuid: "34d8e25d9d9d470282af4c999de8e327" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } } }
14:04:30.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.290427 18148 sys_catalog.cc:458] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [sys.catalog]: This master's current role is: FOLLOWER
14:04:30.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.296139 18150 mvcc.cc:204] Tried to move back new op lower bound from 7287247135630794752 to 7287247135344775168. Current Snapshot: MvccSnapshot[applied={T|T < 7287247135630794752}]
14:04:30.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.308363 18130 sys_catalog.cc:455] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "34d8e25d9d9d470282af4c999de8e327" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } } }
14:04:30.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.309085 18130 sys_catalog.cc:458] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815 [sys.catalog]: This master's current role is: FOLLOWER
14:04:30.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:30.317001 17906 tablet.cc:2404] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:04:30.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.324898 18166 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
14:04:30.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.328293 18148 sys_catalog.cc:455] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "34d8e25d9d9d470282af4c999de8e327" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } } }
14:04:30.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.328955 18148 sys_catalog.cc:458] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3 [sys.catalog]: This master's current role is: FOLLOWER
14:04:30.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.333604 18145 sys_catalog.cc:455] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "34d8e25d9d9d470282af4c999de8e327" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } } }
14:04:30.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.334287 18145 sys_catalog.cc:458] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [sys.catalog]: This master's current role is: LEADER
14:04:30.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.336879 18145 sys_catalog.cc:455] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "34d8e25d9d9d470282af4c999de8e327" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "92e9acb8ad794e89b3811e0ca67e58d3" member_type: VOTER last_known_addr { host: "127.17.115.254" port: 39909 } } peers { permanent_uuid: "802a52d988b64abba97fb5b231c55815" member_type: VOTER last_known_addr { host: "127.17.115.253" port: 42199 } } peers { permanent_uuid: "34d8e25d9d9d470282af4c999de8e327" member_type: VOTER last_known_addr { host: "127.17.115.252" port: 39251 } } }
14:04:30.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.337527 18145 sys_catalog.cc:458] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327 [sys.catalog]: This master's current role is: LEADER
14:04:30.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.341270 18147 catalog_manager.cc:1382] Generated new cluster ID: 114fbe07fe76442cbab2dbb035c4280a
14:04:30.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.341562 18147 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
14:04:30.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.390321 18147 catalog_manager.cc:1405] Generated new certificate authority record
14:04:30.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.397528 18147 catalog_manager.cc:1539] Loading token signing keys...
14:04:30.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.442236 18147 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 34d8e25d9d9d470282af4c999de8e327: Generated new TSK 0
14:04:30.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.443851 18147 catalog_manager.cc:1549] Initializing in-progress tserver states...
14:04:30.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.481837 17871 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:30.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:30.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/wal
14:04:30.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/data
14:04:30.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:04:30.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:04:30.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:04:30.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:30.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:30.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:30.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/logs
14:04:30.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/data/info.pb
14:04:30.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:30.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:04:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:04:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:04:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:04:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:04:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:04:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.193:0
14:04:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.115.193
14:04:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.193
14:04:30.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:30.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:30.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:30.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:30.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:30.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:04:30.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:30.886214 18169 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:04:30.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:30.886804 18169 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:04:30.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:30.887555 18169 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:04:30.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:30.924219 18169 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:04:30.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:30.925540 18169 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.115.193
14:04:30.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.966432 18169 tablet_server_runner.cc:78] Tablet server non-default flags:
14:04:30.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:30.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:30.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:30.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:04:30.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/data
14:04:30.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/wal
14:04:30.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:30.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:30.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.193:0
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/data/info.pb
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.193
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:30.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.115.193
14:04:30.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/logs
14:04:30.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:30.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:04:30.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:04:30.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:04:30.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:04:30.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:04:30.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:04:30.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:22 UTC on e7f111948823
14:04:30.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11959
14:04:30.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:04:30.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.968179 18169 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:04:30.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:30.970417 18169 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:04:30.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:30.993811 18175 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:31.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:31.016374 18141 catalog_manager.cc:1294] Loaded cluster ID: 114fbe07fe76442cbab2dbb035c4280a
14:04:31.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:31.017457 18141 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815: loading cluster ID for follower catalog manager: success
14:04:31.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:31.034461 18141 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815: acquiring CA information for follower catalog manager: success
14:04:31.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:31.051023 18141 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 802a52d988b64abba97fb5b231c55815: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:04:31.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:31.353044 18166 catalog_manager.cc:1294] Loaded cluster ID: 114fbe07fe76442cbab2dbb035c4280a
14:04:31.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:31.354239 18166 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3: loading cluster ID for follower catalog manager: success
14:04:31.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:31.372370 18166 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3: acquiring CA information for follower catalog manager: success
14:04:31.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:31.385730 18166 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 92e9acb8ad794e89b3811e0ca67e58d3: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:04:33.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:32.389621 18174 debug-util.cc:398] Leaking SignalData structure 0x7b08000271c0 after lost signal to thread 18169
14:04:33.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:33.481812 18174 kernel_stack_watchdog.cc:198] Thread 18169 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 393ms:
14:04:33.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
14:04:33.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
14:04:33.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
14:04:33.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
14:04:33.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:33.481963 18169 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 2.488s	user 0.529s	sys 1.001s
14:04:33.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:33.483139 18169 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 2.489s	user 0.529s	sys 1.001s
14:04:33.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:30.998951 18176 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:33.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:33.484117 18177 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection timed out after 2488 milliseconds
14:04:33.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:33.485199 18178 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:33.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.489095 18169 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
14:04:33.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.490587 18169 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:04:33.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.502969 18169 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:04:33.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.506778 18169 hybrid_clock.cc:648] HybridClock initialized: now 1779113073506719 us; error 60 us; skew 500 ppm
14:04:33.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.507966 18169 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:04:33.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.560961 18169 webserver.cc:533] Webserver started at http://127.17.115.193:41143/ using document root <none> and password file <none>
14:04:33.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.562232 18169 fs_manager.cc:362] Metadata directory not provided
14:04:33.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.562526 18169 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:04:33.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.563130 18169 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:04:33.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.569757 18169 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/data/instance:
14:04:33.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c7846994daa24dd799e79efcb7621b10"
14:04:33.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:33 on dist-test-slave-jqdf"
14:04:33.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.571318 18169 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/wal/instance:
14:04:33.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c7846994daa24dd799e79efcb7621b10"
14:04:33.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:33 on dist-test-slave-jqdf"
14:04:33.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.586782 18169 fs_manager.cc:696] Time spent creating directory manager: real 0.015s	user 0.009s	sys 0.005s
14:04:33.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.600174 18189 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:04:33.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.601605 18169 fs_manager.cc:730] Time spent opening block manager: real 0.010s	user 0.000s	sys 0.008s
14:04:33.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.602015 18169 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/data,/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/wal
14:04:33.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c7846994daa24dd799e79efcb7621b10"
14:04:33.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:33 on dist-test-slave-jqdf"
14:04:33.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.602578 18169 fs_report.cc:389] FS layout report
14:04:33.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:04:33.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/wal
14:04:33.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/wal
14:04:33.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/data/data
14:04:33.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:04:33.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:04:33.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:04:33.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:04:33.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:04:33.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:04:33.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:04:33.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:04:33.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:04:33.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:04:33.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:04:33.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.698951 18169 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:04:33.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.701229 18169 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
14:04:33.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.701777 18169 kserver.cc:163] Server-wide thread pool size limit: 3276
14:04:33.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.715548 18169 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:04:33.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.727392 18169 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:04:33.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.727689 18169 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:04:33.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.727981 18169 ts_tablet_manager.cc:616] Registered 0 tablets
14:04:33.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:33.728219 18169 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:04:34.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.124306 18169 rpc_server.cc:307] RPC server started. Bound to: 127.17.115.193:33979
14:04:34.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.124323 18302 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.115.193:33979 every 8 connection(s)
14:04:34.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.127437 18169 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/data/info.pb
14:04:34.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.136828 17871 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu as pid 18169
14:04:34.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.137507 17871 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-0/wal/instance
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.192548 17871 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/wal
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/data
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/logs
14:04:34.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/data/info.pb
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.194:0
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.115.194
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.194
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:34.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:34.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:34.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:34.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:34.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:04:34.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.229853 18304 heartbeater.cc:344] Connected to a master server at 127.17.115.253:42199
14:04:34.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.230363 18304 heartbeater.cc:461] Registering TS with master...
14:04:34.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.231885 18304 heartbeater.cc:507] Master 127.17.115.253:42199 requested a full tablet report, sending...
14:04:34.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.236660 17992 ts_manager.cc:194] Registered new tserver with Master: c7846994daa24dd799e79efcb7621b10 (127.17.115.193:33979)
14:04:34.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.255261 18303 heartbeater.cc:344] Connected to a master server at 127.17.115.252:39251
14:04:34.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.255640 18303 heartbeater.cc:461] Registering TS with master...
14:04:34.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.256531 18303 heartbeater.cc:507] Master 127.17.115.252:39251 requested a full tablet report, sending...
14:04:34.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.264139 18309 heartbeater.cc:344] Connected to a master server at 127.17.115.254:39909
14:04:34.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.264547 18309 heartbeater.cc:461] Registering TS with master...
14:04:34.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.265448 18309 heartbeater.cc:507] Master 127.17.115.254:39909 requested a full tablet report, sending...
14:04:34.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.265890 18072 ts_manager.cc:194] Registered new tserver with Master: c7846994daa24dd799e79efcb7621b10 (127.17.115.193:33979)
14:04:34.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.268520 18072 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.17.115.193:50303
14:04:34.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.272616 17917 ts_manager.cc:194] Registered new tserver with Master: c7846994daa24dd799e79efcb7621b10 (127.17.115.193:33979)
14:04:34.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:34.589566 18313 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:04:34.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:34.590117 18313 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:04:34.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:34.590718 18313 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:04:34.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:34.624667 18313 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:04:34.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:34.625718 18313 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.115.194
14:04:34.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.663924 18313 tablet_server_runner.cc:78] Tablet server non-default flags:
14:04:34.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:34.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:34.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:34.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/data
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/wal
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.194:0
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/data/info.pb
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.194
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:34.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.115.194
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/logs
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:04:34.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:22 UTC on e7f111948823
14:04:34.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11959
14:04:34.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:04:34.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.665666 18313 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:04:34.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:34.667794 18313 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:04:34.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:34.681303 18319 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:35.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:35.277107 18303 heartbeater.cc:499] Master 127.17.115.252:39251 was elected leader, sending a full tablet report...
14:04:36.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:34.684655 18320 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:36.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.085793 18318 debug-util.cc:398] Leaking SignalData structure 0x7b08000271c0 after lost signal to thread 18313
14:04:36.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.126971 18313 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.445s	user 0.513s	sys 0.883s
14:04:36.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.128822 18313 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.447s	user 0.514s	sys 0.883s
14:04:36.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.129614 18321 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1445 milliseconds
14:04:36.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.130206 18313 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
14:04:36.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.130298 18322 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:36.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.135802 18313 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:04:36.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.138228 18313 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:04:36.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.139660 18313 hybrid_clock.cc:648] HybridClock initialized: now 1779113076139623 us; error 36 us; skew 500 ppm
14:04:36.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.140645 18313 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:04:36.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.147167 18313 webserver.cc:533] Webserver started at http://127.17.115.194:40149/ using document root <none> and password file <none>
14:04:36.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.148231 18313 fs_manager.cc:362] Metadata directory not provided
14:04:36.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.148677 18313 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:04:36.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.149381 18313 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:04:36.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.156409 18313 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/data/instance:
14:04:36.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cf3b154671b840abb738b5d61cfc5abd"
14:04:36.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:36 on dist-test-slave-jqdf"
14:04:36.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.157713 18313 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/wal/instance:
14:04:36.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cf3b154671b840abb738b5d61cfc5abd"
14:04:36.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:36 on dist-test-slave-jqdf"
14:04:36.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.164705 18313 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.000s	sys 0.008s
14:04:36.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.170315 18330 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:04:36.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.171538 18313 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.001s
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.171839 18313 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/data,/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/wal
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cf3b154671b840abb738b5d61cfc5abd"
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:36 on dist-test-slave-jqdf"
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.172138 18313 fs_report.cc:389] FS layout report
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/wal
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/wal
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/data/data
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:04:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:04:36.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:04:36.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:04:36.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:04:36.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.226492 18313 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:04:36.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.227977 18313 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
14:04:36.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.228394 18313 kserver.cc:163] Server-wide thread pool size limit: 3276
14:04:36.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.231081 18313 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:04:36.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.235471 18313 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:04:36.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.235743 18313 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:04:36.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.236037 18313 ts_tablet_manager.cc:616] Registered 0 tablets
14:04:36.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.236284 18313 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:04:36.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.379920 18313 rpc_server.cc:307] RPC server started. Bound to: 127.17.115.194:33415
14:04:36.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.379999 18442 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.115.194:33415 every 8 connection(s)
14:04:36.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.382530 18313 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/data/info.pb
14:04:36.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.390480 17871 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu as pid 18313
14:04:36.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.391068 17871 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-1/wal/instance
14:04:36.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.409282 17871 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:36.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/wal
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/data
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/logs
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/data/info.pb
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.195:0
14:04:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.115.195
14:04:36.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.195
14:04:36.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:36.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:36.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:36.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:36.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:36.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:04:36.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.440325 18444 heartbeater.cc:344] Connected to a master server at 127.17.115.253:42199
14:04:36.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.440919 18444 heartbeater.cc:461] Registering TS with master...
14:04:36.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.442134 18443 heartbeater.cc:344] Connected to a master server at 127.17.115.252:39251
14:04:36.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.442523 18443 heartbeater.cc:461] Registering TS with master...
14:04:36.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.442484 18444 heartbeater.cc:507] Master 127.17.115.253:42199 requested a full tablet report, sending...
14:04:36.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.443603 18443 heartbeater.cc:507] Master 127.17.115.252:39251 requested a full tablet report, sending...
14:04:36.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.446280 18445 heartbeater.cc:344] Connected to a master server at 127.17.115.254:39909
14:04:36.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.446369 18072 ts_manager.cc:194] Registered new tserver with Master: cf3b154671b840abb738b5d61cfc5abd (127.17.115.194:33415)
14:04:36.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.446401 17992 ts_manager.cc:194] Registered new tserver with Master: cf3b154671b840abb738b5d61cfc5abd (127.17.115.194:33415)
14:04:36.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.446678 18445 heartbeater.cc:461] Registering TS with master...
14:04:36.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.447579 18445 heartbeater.cc:507] Master 127.17.115.254:39909 requested a full tablet report, sending...
14:04:36.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.448114 18072 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.17.115.194:46091
14:04:36.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.450189 17917 ts_manager.cc:194] Registered new tserver with Master: cf3b154671b840abb738b5d61cfc5abd (127.17.115.194:33415)
14:04:36.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.759024 18453 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:04:36.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.759596 18453 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:04:36.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.760242 18453 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:04:36.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.794085 18453 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:04:36.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.795056 18453 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.115.195
14:04:36.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.832880 18453 tablet_server_runner.cc:78] Tablet server non-default flags:
14:04:36.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:04:36.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.115.212:35749
14:04:36.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:04:36.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:04:36.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/data
14:04:36.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/wal
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.115.195:0
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/data/info.pb
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.115.195
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.115.254:39909,127.17.115.253:42199,127.17.115.252:39251
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.115.195
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/logs
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:04:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:04:36.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:04:36.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:04:36.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:04:36.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:04:36.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:22 UTC on e7f111948823
14:04:36.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11959
14:04:36.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:04:36.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.834589 18453 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:04:36.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:36.836393 18453 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:04:36.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.848819 18459 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:37.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:37.453490 18443 heartbeater.cc:499] Master 127.17.115.252:39251 was elected leader, sending a full tablet report...
14:04:38.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:38.255002 18458 debug-util.cc:398] Leaking SignalData structure 0x7b08000271c0 after lost signal to thread 18453
14:04:38.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:38.437675 18458 kernel_stack_watchdog.cc:198] Thread 18453 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 403ms:
14:04:38.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
14:04:38.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
14:04:38.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
14:04:38.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
14:04:38.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:38.438397 18453 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.590s	user 0.488s	sys 1.082s
14:04:38.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:38.438748 18453 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.590s	user 0.488s	sys 1.082s
14:04:38.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:36.849145 18460 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:38.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:38.441197 18462 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:04:38.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:38.443975 18461 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1589 milliseconds
14:04:38.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.443993 18453 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
14:04:38.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.445291 18453 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:04:38.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.447329 18453 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:04:38.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.448719 18453 hybrid_clock.cc:648] HybridClock initialized: now 1779113078448677 us; error 42 us; skew 500 ppm
14:04:38.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.449594 18453 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:04:38.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.455613 18453 webserver.cc:533] Webserver started at http://127.17.115.195:42729/ using document root <none> and password file <none>
14:04:38.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.456562 18453 fs_manager.cc:362] Metadata directory not provided
14:04:38.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.456801 18453 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:04:38.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.457334 18453 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:04:38.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.462491 18453 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/data/instance:
14:04:38.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "73a029e396644db0b40d9aff24ee320b"
14:04:38.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:38 on dist-test-slave-jqdf"
14:04:38.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.464182 18453 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/wal/instance:
14:04:38.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "73a029e396644db0b40d9aff24ee320b"
14:04:38.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:38 on dist-test-slave-jqdf"
14:04:38.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.474264 18453 fs_manager.cc:696] Time spent creating directory manager: real 0.009s	user 0.001s	sys 0.009s
14:04:38.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.481740 18470 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:04:38.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.482909 18453 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.006s	sys 0.000s
14:04:38.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.483258 18453 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/data,/tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/wal
14:04:38.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "73a029e396644db0b40d9aff24ee320b"
14:04:38.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:04:38 on dist-test-slave-jqdf"
14:04:38.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.483556 18453 fs_report.cc:389] FS layout report
14:04:38.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:04:38.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/wal
14:04:38.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/wal
14:04:38.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/data/data
14:04:38.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:04:38.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:04:38.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:04:38.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:04:38.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:04:38.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:04:38.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:04:38.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:04:38.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:04:38.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:04:38.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:04:38.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.537614 18453 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:04:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.539603 18453 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
14:04:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.540088 18453 kserver.cc:163] Server-wide thread pool size limit: 3276
14:04:38.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.542896 18453 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:04:38.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.547703 18453 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:04:38.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.547925 18453 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:04:38.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.548183 18453 ts_tablet_manager.cc:616] Registered 0 tablets
14:04:38.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.548487 18453 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.001s	sys 0.001s
14:04:38.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.683013 18453 rpc_server.cc:307] RPC server started. Bound to: 127.17.115.195:41153
14:04:38.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.683151 18582 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.115.195:41153 every 8 connection(s)
14:04:38.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.685607 18453 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/data/info.pb
14:04:38.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.691794 17871 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu as pid 18453
14:04:38.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.692394 17871 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskI5wjnm/test-tmp/mini-kudu-cluster5677735052611383589/ts-2/wal/instance
14:04:38.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.748657 18583 heartbeater.cc:344] Connected to a master server at 127.17.115.252:39251
14:04:38.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.749235 18583 heartbeater.cc:461] Registering TS with master...
14:04:38.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.750607 18583 heartbeater.cc:507] Master 127.17.115.252:39251 requested a full tablet report, sending...
14:04:38.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.753427 18072 ts_manager.cc:194] Registered new tserver with Master: 73a029e396644db0b40d9aff24ee320b (127.17.115.195:41153)
14:04:38.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.755615 18072 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.17.115.195:48707
14:04:38.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.761232 18584 heartbeater.cc:344] Connected to a master server at 127.17.115.253:42199
14:04:38.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.761754 18584 heartbeater.cc:461] Registering TS with master...
14:04:38.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.762629 18584 heartbeater.cc:507] Master 127.17.115.253:42199 requested a full tablet report, sending...
14:04:38.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.765672 17992 ts_manager.cc:194] Registered new tserver with Master: 73a029e396644db0b40d9aff24ee320b (127.17.115.195:41153)
14:04:38.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.773651 18585 heartbeater.cc:344] Connected to a master server at 127.17.115.254:39909
14:04:38.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.774068 18585 heartbeater.cc:461] Registering TS with master...
14:04:38.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.774858 18585 heartbeater.cc:507] Master 127.17.115.254:39909 requested a full tablet report, sending...
14:04:38.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.777386 17917 ts_manager.cc:194] Registered new tserver with Master: 73a029e396644db0b40d9aff24ee320b (127.17.115.195:41153)
14:04:38.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:38.781095 17871 external_mini_cluster.cc:949] 3 TS(s) registered with all masters
14:04:38.792 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:04:38.793 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

14:04:38.803 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.17.115.254"
      port: 39909
    }
    bound_http_address {
      host: "127.17.115.254"
      port: 38581
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.17.115.253"
      port: 42199
    }
    bound_http_address {
      host: "127.17.115.253"
      port: 33617
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.17.115.252"
      port: 39251
    }
    bound_http_address {
      host: "127.17.115.252"
      port: 46117
    }
  }
}

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

14:04:38.808 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.17.115.193"
      port: 33979
    }
    bound_http_address {
      host: "127.17.115.193"
      port: 41143
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.17.115.194"
      port: 33415
    }
    bound_http_address {
      host: "127.17.115.194"
      port: 40149
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.17.115.195"
      port: 41153
    }
    bound_http_address {
      host: "127.17.115.195"
      port: 42729
    }
  }
}

14:04:38.808 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
14:04:38.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:04:38.871539 17948 debug-util.cc:398] Leaking SignalData structure 0x7b0800099a00 after lost signal to thread 17885
14:04:39.022 [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)
14:04:39.094 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
14:04:39.247 [DEBUG - Time-limited test] (Connection.java:748) [peer master-127.17.115.254:39909(127.17.115.254:39909)] connecting to peer
14:04:39.325 [DEBUG - Time-limited test] (Connection.java:748) [peer master-127.17.115.253:42199(127.17.115.253:42199)] connecting to peer
14:04:39.335 [DEBUG - Time-limited test] (Connection.java:748) [peer master-127.17.115.252:39251(127.17.115.252:39251)] connecting to peer
14:04:39.363 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.17.115.253:42199(127.17.115.253:42199)] Successfully connected to peer
14:04:39.366 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.17.115.252:39251(127.17.115.252:39251)] Successfully connected to peer
14:04:39.367 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.17.115.254:39909(127.17.115.254:39909)] Successfully connected to peer
14:04:39.482 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.17.115.252
14:04:39.483 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.17.115.253
14:04:39.484 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.17.115.254
14:04:39.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:39.760095 18583 heartbeater.cc:499] Master 127.17.115.252:39251 was elected leader, sending a full tablet report...
14:04:39.798 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x675d1cfe, L:/127.0.0.1:43890 - R:/127.17.115.254:39909] using SASL/PLAIN
14:04:39.798 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xe4a81fd2, L:/127.0.0.1:51440 - R:/127.17.115.253:42199] using SASL/PLAIN
14:04:39.799 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0xc80afb19, L:/127.0.0.1:37628 - R:/127.17.115.252:39251] using SASL/PLAIN
14:04:39.842 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:04:39.843 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=636), Traces: [0ms] refreshing cache from master, [21ms] Sub RPC ConnectToMaster: sending RPC to server master-127.17.115.254:39909, [113ms] Sub RPC ConnectToMaster: sending RPC to server master-127.17.115.253:42199, [124ms] Sub RPC ConnectToMaster: sending RPC to server master-127.17.115.252:39251, [607ms] Sub RPC ConnectToMaster: received response from server master-127.17.115.254:39909: OK, [607ms] Sub RPC ConnectToMaster: received response from server master-127.17.115.253:42199: OK, [607ms] Sub RPC ConnectToMaster: received response from server master-127.17.115.252:39251: OK, deferred=null) after lookup
14:04:39.857 [DEBUG - Time-limited test] (Connection.java:575) [peer master-127.17.115.254:39909(127.17.115.254:39909)] disconnecting while in state READY
14:04:39.863 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.17.115.254:39909(127.17.115.254:39909)] handling channelInactive
14:04:39.864 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.17.115.254:39909(127.17.115.254:39909)] cleaning up while in state READY due to: connection closed
14:04:40.615 [DEBUG - Time-limited test] (Connection.java:748) [peer fake-uuid(127.17.115.254:39909)] connecting to peer
14:04:40.618 [DEBUG - kudu-nio-3] (Connection.java:757) [peer fake-uuid(127.17.115.254:39909)] Successfully connected to peer
14:04:40.720 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x68f4db70, L:/127.0.0.1:43896 - R:/127.17.115.254:39909] using TOKEN/null
14:04:40.728 [DEBUG - Time-limited test] (Connection.java:575) [peer fake-uuid(127.17.115.254:39909)] disconnecting while in state READY
14:04:40.730 [DEBUG - kudu-nio-3] (Connection.java:239) [peer fake-uuid(127.17.115.254:39909)] handling channelInactive
14:04:40.730 [DEBUG - kudu-nio-3] (Connection.java:709) [peer fake-uuid(127.17.115.254:39909)] cleaning up while in state READY due to: connection closed
14:04:40.980 [DEBUG - Time-limited test] (Connection.java:575) [peer master-127.17.115.253:42199(127.17.115.253:42199)] disconnecting while in state READY
14:04:40.982 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.17.115.253:42199(127.17.115.253:42199)] handling channelInactive
14:04:40.982 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.17.115.253:42199(127.17.115.253:42199)] cleaning up while in state READY due to: connection closed
14:04:41.232 [DEBUG - Time-limited test] (Connection.java:575) [peer master-127.17.115.252:39251(127.17.115.252:39251)] disconnecting while in state READY
14:04:41.234 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.17.115.252:39251(127.17.115.252:39251)] handling channelInactive
14:04:41.234 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.17.115.252:39251(127.17.115.252:39251)] cleaning up while in state READY due to: connection closed
14:04:41.485 [DEBUG - main] (Connection.java:575) [peer fake-uuid(127.17.115.254:39909)] disconnecting while in state TERMINATED
14:04:41.486 [DEBUG - main] (Connection.java:575) [peer master-127.17.115.253:42199(127.17.115.253:42199)] disconnecting while in state TERMINATED
14:04:41.487 [DEBUG - main] (Connection.java:575) [peer master-127.17.115.252:39251(127.17.115.252:39251)] disconnecting while in state TERMINATED
14:04:41.488 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:04:41.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:41.491042 17871 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu with pid 18169
14:04:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:41.513875 17871 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu with pid 18313
14:04:41.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:41.541457 17871 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu with pid 18453
14:04:41.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:41.568481 17871 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu with pid 17884
14:04:41.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:41.597565 17871 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu with pid 17954
14:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:04:41.622598 17871 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskI5wjnm/build/tsan/bin/kudu with pid 18029
14:04:42.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:04:42Z chronyd exiting

Time: 21.678

OK (1 test)

