JUnit version 4.13.2
.08:01:02.682 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783497662674
08:01:02.728 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
08:01:02.783 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
08:01:02.794 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task4PYGkC/test-tmp
08:01:02.800 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
08:01:02.802 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task4PYGkC/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
08:01:03.062 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

08:01:03.243 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
08:01:03.245 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

08:01:03.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:03.248888 31192 mini_oidc.cc:150] Starting JWKS server
08:01:03.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:03.252313 31192 webserver.cc:533] Webserver started at http://127.0.0.1:39155/ using document root <none> and password file <none>
08:01:03.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:03.252782 31192 mini_oidc.cc:186] Starting OIDC Discovery server
08:01:03.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:03.255016 31192 webserver.cc:533] Webserver started at http://127.0.0.1:42667/ using document root <none> and password file <none>
08:01:03.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T08:01:03Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
08:01:03.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T08:01:03Z Disabled control of system clock
08:01:03.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:03.318276 31192 external_mini_cluster.cc:1372] Running /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:03.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:03.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/wal
08:01:03.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/data
08:01:03.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:01:03.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:01:03.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:01:03.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:03.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:03.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:03.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/logs
08:01:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/data/info.pb
08:01:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:01:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:01:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:01:03.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:01:03.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:03.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:03.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:03.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
08:01:03.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:01:03.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:01:03.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:01:03.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.62:46193
08:01:03.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.62
08:01:03.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:03.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:03.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:03.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:03.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:01:03.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:01:03.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:03.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:01:03.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39155/jwks.json with env {}
08:01:03.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:03.623153 31204 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:01:03.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:03.623723 31204 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:01:03.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:03.624225 31204 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:01:03.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:03.657403 31204 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
08:01:03.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:03.657683 31204 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:01:03.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:03.658002 31204 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
08:01:03.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:03.658321 31204 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
08:01:03.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:03.658526 31204 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
08:01:03.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:03.658699 31204 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39155/jwks.json
08:01:03.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:03.696108 31204 master_runner.cc:387] Master server non-default flags:
08:01:03.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:03.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:03.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:03.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:01:03.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/data
08:01:03.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/wal
08:01:03.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:01:03.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:03.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:03.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:03.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:01:03.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.62:46193
08:01:03.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:01:03.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:01:03.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:01:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39155/jwks.json
08:01:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/data/info.pb
08:01:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.62
08:01:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:01:03.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:03.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:01:03.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:01:03.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:03.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/logs
08:01:03.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:03.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:01:03.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:01:03.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
08:01:03.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:01:03.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
08:01:03.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:01:03.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 07:43:22 UTC on e7f111948823
08:01:03.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12771
08:01:03.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:01:03.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:03.697608 31204 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:01:03.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:03.699745 31204 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:01:03.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:03.712468 31210 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
08:01:05.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:05.116120 31209 debug-util.cc:398] Leaking SignalData structure 0x7b0800028020 after lost signal to thread 31204
08:01:05.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:05.574414 31209 kernel_stack_watchdog.cc:198] Thread 31204 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 400ms:
08:01:05.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
08:01:05.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
08:01:05.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
08:01:05.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
08:01:05.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:05.574770 31204 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.862s	user 0.714s	sys 1.147s
08:01:05.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:05.575115 31204 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.862s	user 0.714s	sys 1.147s
08:01:05.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:03.713310 31211 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
08:01:05.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:05.576265 31212 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1861 milliseconds
08:01:05.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.578153 31204 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
08:01:05.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:05.578202 31213 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
08:01:05.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.582744 31204 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:01:05.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.585194 31204 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:01:05.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.586642 31204 hybrid_clock.cc:648] HybridClock initialized: now 1783497665586621 us; error 83 us; skew 500 ppm
08:01:05.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.587492 31204 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:01:05.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.593915 31204 webserver.cc:533] Webserver started at http://127.30.118.62:44061/ using document root <none> and password file <none>
08:01:05.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.594919 31204 fs_manager.cc:362] Metadata directory not provided
08:01:05.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.595121 31204 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:01:05.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.595573 31204 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:01:05.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.599871 31204 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/data/instance:
08:01:05.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e43109ca94214105a8a9f1d986d2ebac"
08:01:05.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:05 on dist-test-slave-j0xp"
08:01:05.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.601125 31204 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/wal/instance:
08:01:05.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e43109ca94214105a8a9f1d986d2ebac"
08:01:05.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:05 on dist-test-slave-j0xp"
08:01:05.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.610581 31204 fs_manager.cc:696] Time spent creating directory manager: real 0.009s	user 0.006s	sys 0.002s
08:01:05.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.616252 31220 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:01:05.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.617651 31204 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.005s	sys 0.001s
08:01:05.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.618093 31204 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/data,/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/wal
08:01:05.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e43109ca94214105a8a9f1d986d2ebac"
08:01:05.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:05 on dist-test-slave-j0xp"
08:01:05.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.618553 31204 fs_report.cc:389] FS layout report
08:01:05.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:01:05.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/wal
08:01:05.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/wal
08:01:05.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/data/data
08:01:05.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:01:05.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:01:05.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:01:05.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:01:05.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:01:05.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:01:05.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:01:05.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:01:05.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:01:05.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:01:05.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:01:05.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.676316 31204 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:01:05.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.678112 31204 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:01:05.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.678587 31204 kserver.cc:163] Server-wide thread pool size limit: 3276
08:01:05.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.749320 31204 rpc_server.cc:307] RPC server started. Bound to: 127.30.118.62:46193
08:01:05.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.749400 31271 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.30.118.62:46193 every 8 connection(s)
08:01:05.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.752285 31204 server_base.cc:1193] Dumped server information to /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/data/info.pb
08:01:05.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.758128 31272 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
08:01:05.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.760660 31192 external_mini_cluster.cc:1434] Started /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu as pid 31204
08:01:05.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.761106 31192 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-0/wal/instance
08:01:05.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.764693 31192 external_mini_cluster.cc:1372] Running /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:05.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:05.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/wal
08:01:05.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/data
08:01:05.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:01:05.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:01:05.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:01:05.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:05.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:05.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:05.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/logs
08:01:05.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/data/info.pb
08:01:05.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:05.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:01:05.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:01:05.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:01:05.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:01:05.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:05.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:05.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:05.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
08:01:05.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:01:05.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:01:05.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:01:05.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.61:40141
08:01:05.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.61
08:01:05.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:05.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:05.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:05.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:05.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:01:05.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:01:05.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:05.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:01:05.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39155/jwks.json with env {}
08:01:05.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.769393 31272 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } has no permanent_uuid. Determining permanent_uuid...
08:01:05.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.798228 31272 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } has no permanent_uuid. Determining permanent_uuid...
08:01:05.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:05.800951 31224 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.30.118.61:40141: connect: Connection refused (error 111)
08:01:05.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:05.805559 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.61:40141: Network error: Client connection negotiation failed: client connection to 127.30.118.61:40141: connect: Connection refused (error 111)
08:01:05.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.855075 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } attempt: 1
08:01:05.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:05.860183 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.61:40141: Network error: Client connection negotiation failed: client connection to 127.30.118.61:40141: connect: Connection refused (error 111)
08:01:05.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:05.928567 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } attempt: 2
08:01:05.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:05.932679 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.61:40141: Network error: Client connection negotiation failed: client connection to 127.30.118.61:40141: connect: Connection refused (error 111)
08:01:06.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:06.024153 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } attempt: 3
08:01:06.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.028975 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.61:40141: Network error: Client connection negotiation failed: client connection to 127.30.118.61:40141: connect: Connection refused (error 111)
08:01:06.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.080786 31274 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:01:06.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.081490 31274 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:01:06.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.082321 31274 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:01:06.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.115032 31274 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
08:01:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.115410 31274 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:01:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.115726 31274 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
08:01:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.116073 31274 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
08:01:06.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.116456 31274 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
08:01:06.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.116781 31274 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39155/jwks.json
08:01:06.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:06.153477 31274 master_runner.cc:387] Master server non-default flags:
08:01:06.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:06.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:06.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:06.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:01:06.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/data
08:01:06.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/wal
08:01:06.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:01:06.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:06.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:06.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:06.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:01:06.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.61:40141
08:01:06.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:01:06.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:01:06.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:01:06.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39155/jwks.json
08:01:06.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:06.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:06.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/data/info.pb
08:01:06.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.61
08:01:06.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:06.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:01:06.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:06.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:01:06.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:01:06.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:06.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/logs
08:01:06.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:06.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:01:06.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:01:06.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
08:01:06.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:01:06.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
08:01:06.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:01:06.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 07:43:22 UTC on e7f111948823
08:01:06.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12771
08:01:06.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:01:06.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:06.155202 31274 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:01:06.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:06.157522 31274 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:01:06.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.170583 31283 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
08:01:06.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:06.172396 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } attempt: 4
08:01:06.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.178260 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.61:40141: Network error: Client connection negotiation failed: client connection to 127.30.118.61:40141: connect: Connection refused (error 111)
08:01:06.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:06.477778 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } attempt: 5
08:01:06.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.485365 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.61:40141: Network error: Client connection negotiation failed: client connection to 127.30.118.61:40141: connect: Connection refused (error 111)
08:01:07.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.032970 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } attempt: 6
08:01:07.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.051614 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.61:40141: Network error: Client connection negotiation failed: client connection to 127.30.118.61:40141: connect: Connection refused (error 111)
08:01:07.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:06.171170 31284 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
08:01:07.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.404165 31285 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
08:01:07.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.404896 31286 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
08:01:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.407902 31274 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.238s	user 0.478s	sys 0.757s
08:01:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.408608 31274 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.238s	user 0.479s	sys 0.758s
08:01:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.409237 31274 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
08:01:07.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.411446 31274 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:01:07.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.414462 31274 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:01:07.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.416361 31274 hybrid_clock.cc:648] HybridClock initialized: now 1783497667416275 us; error 89 us; skew 500 ppm
08:01:07.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.417560 31274 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:01:07.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.424822 31274 webserver.cc:533] Webserver started at http://127.30.118.61:44531/ using document root <none> and password file <none>
08:01:07.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.425979 31274 fs_manager.cc:362] Metadata directory not provided
08:01:07.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.426226 31274 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:01:07.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.426849 31274 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:01:07.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.431231 31274 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/data/instance:
08:01:07.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4252c730346f45e090cd3f97d8de1fb7"
08:01:07.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:07 on dist-test-slave-j0xp"
08:01:07.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.432241 31274 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/wal/instance:
08:01:07.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4252c730346f45e090cd3f97d8de1fb7"
08:01:07.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:07 on dist-test-slave-j0xp"
08:01:07.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.440002 31274 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.006s	sys 0.003s
08:01:07.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.446266 31295 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:01:07.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.447446 31274 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.001s
08:01:07.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.447800 31274 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/data,/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/wal
08:01:07.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4252c730346f45e090cd3f97d8de1fb7"
08:01:07.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:07 on dist-test-slave-j0xp"
08:01:07.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.448246 31274 fs_report.cc:389] FS layout report
08:01:07.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:01:07.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/wal
08:01:07.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/wal
08:01:07.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/data/data
08:01:07.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:01:07.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:01:07.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:01:07.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:01:07.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:01:07.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:01:07.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:01:07.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:01:07.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:01:07.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:01:07.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:01:07.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.527318 31274 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:01:07.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.528956 31274 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:01:07.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.529497 31274 kserver.cc:163] Server-wide thread pool size limit: 3276
08:01:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.602572 31274 rpc_server.cc:307] RPC server started. Bound to: 127.30.118.61:40141
08:01:07.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.602615 31346 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.30.118.61:40141 every 8 connection(s)
08:01:07.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.605473 31274 server_base.cc:1193] Dumped server information to /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/data/info.pb
08:01:07.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.609613 31192 external_mini_cluster.cc:1434] Started /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu as pid 31274
08:01:07.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.610018 31192 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-1/wal/instance
08:01:07.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.611524 31347 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
08:01:07.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.612702 31192 external_mini_cluster.cc:1372] Running /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:07.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:07.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/wal
08:01:07.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/data
08:01:07.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:01:07.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:01:07.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:01:07.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:07.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:07.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:07.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/logs
08:01:07.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/data/info.pb
08:01:07.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:07.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:01:07.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:01:07.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:01:07.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:01:07.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:07.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:07.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:07.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
08:01:07.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:01:07.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:01:07.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:01:07.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.60:40871
08:01:07.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.60
08:01:07.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:07.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:07.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:07.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:07.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:01:07.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:01:07.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:07.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:01:07.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39155/jwks.json with env {}
08:01:07.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.628947 31347 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } has no permanent_uuid. Determining permanent_uuid...
08:01:07.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.658317 31347 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } has no permanent_uuid. Determining permanent_uuid...
08:01:07.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.673713 31347 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } has no permanent_uuid. Determining permanent_uuid...
08:01:07.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.676123 31299 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:07.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.680487 31347 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:07.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.730032 31347 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 1
08:01:07.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.734385 31347 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:07.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.802831 31347 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 2
08:01:07.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.807127 31347 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:07.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:07.898583 31347 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 3
08:01:07.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.902917 31347 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:07.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.931548 31349 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:01:07.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.932108 31349 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:01:07.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.932585 31349 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:01:07.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.965441 31349 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
08:01:07.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.965731 31349 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:01:07.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.966001 31349 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
08:01:07.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.966197 31349 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
08:01:07.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.966385 31349 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
08:01:07.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:07.966533 31349 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39155/jwks.json
08:01:08.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.004750 31349 master_runner.cc:387] Master server non-default flags:
08:01:08.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:08.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:08.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:08.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:01:08.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/data
08:01:08.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/wal
08:01:08.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:01:08.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:08.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:08.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:08.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:01:08.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.60:40871
08:01:08.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:01:08.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:01:08.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:01:08.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39155/jwks.json
08:01:08.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:08.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:08.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/data/info.pb
08:01:08.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.60
08:01:08.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:08.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:01:08.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:08.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:01:08.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:01:08.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:08.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/logs
08:01:08.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:08.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:01:08.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:01:08.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
08:01:08.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:01:08.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
08:01:08.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:01:08.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 07:43:22 UTC on e7f111948823
08:01:08.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12771
08:01:08.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:01:08.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.006145 31349 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:01:08.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.007836 31349 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:01:08.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:08.019068 31359 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
08:01:08.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.046361 31347 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 4
08:01:08.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:08.053474 31347 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:08.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.112249 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } attempt: 7
08:01:08.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.143858 31272 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } has no permanent_uuid. Determining permanent_uuid...
08:01:08.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:08.171660 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:08.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.230213 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 1
08:01:08.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:08.238729 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:08.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.320276 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 2
08:01:08.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:08.329782 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:08.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.353050 31347 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 5
08:01:08.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:08.361701 31347 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:08.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.415334 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 3
08:01:08.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:08.426934 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:08.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.567482 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 4
08:01:08.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:08.576079 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:08.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.859625 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 5
08:01:08.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:08.868021 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:08.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:08.909268 31347 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 6
08:01:08.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:08.940716 31347 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:09.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.420595 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 6
08:01:09.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:09.451514 31272 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:09.422199 31358 debug-util.cc:398] Leaking SignalData structure 0x7b0800028020 after lost signal to thread 31349
08:01:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:08.019915 31360 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
08:01:09.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:09.842952 31358 kernel_stack_watchdog.cc:198] Thread 31349 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 400ms:
08:01:09.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
08:01:09.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
08:01:09.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
08:01:09.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
08:01:09.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:09.843568 31349 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.824s	user 0.678s	sys 1.140s
08:01:09.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:09.843922 31349 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.825s	user 0.678s	sys 1.140s
08:01:09.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:09.845134 31362 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
08:01:09.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:09.847726 31361 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1822 milliseconds
08:01:09.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.847750 31349 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
08:01:09.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.848968 31349 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:01:09.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.851886 31349 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:01:09.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.853294 31349 hybrid_clock.cc:648] HybridClock initialized: now 1783497669853258 us; error 41 us; skew 500 ppm
08:01:09.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.854327 31349 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:01:09.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.860877 31349 webserver.cc:533] Webserver started at http://127.30.118.60:40029/ using document root <none> and password file <none>
08:01:09.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.862025 31349 fs_manager.cc:362] Metadata directory not provided
08:01:09.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.862303 31349 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:01:09.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.862875 31349 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:01:09.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.867471 31349 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/data/instance:
08:01:09.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0ad39eb6008b473f867899c360be64f0"
08:01:09.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:09 on dist-test-slave-j0xp"
08:01:09.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.869396 31349 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/wal/instance:
08:01:09.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0ad39eb6008b473f867899c360be64f0"
08:01:09.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:09 on dist-test-slave-j0xp"
08:01:09.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.877905 31349 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.007s	sys 0.000s
08:01:09.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.884971 31376 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:01:09.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.886307 31349 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.007s	sys 0.000s
08:01:09.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.886695 31349 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/data,/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/wal
08:01:09.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0ad39eb6008b473f867899c360be64f0"
08:01:09.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:09 on dist-test-slave-j0xp"
08:01:09.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.887111 31349 fs_report.cc:389] FS layout report
08:01:09.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:01:09.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/wal
08:01:09.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/wal
08:01:09.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/data/data
08:01:09.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:01:09.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:01:09.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:01:09.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:01:09.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:01:09.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:01:09.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:01:09.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:01:09.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:01:09.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:01:09.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:01:09.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.953724 31349 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:01:09.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.955395 31349 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:01:09.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:09.955928 31349 kserver.cc:163] Server-wide thread pool size limit: 3276
08:01:10.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.001269 31347 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 7
08:01:10.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:10.011466 31347 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.30.118.60:40871: Network error: Client connection negotiation failed: client connection to 127.30.118.60:40871: connect: Connection refused (error 111)
08:01:10.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.039352 31349 rpc_server.cc:307] RPC server started. Bound to: 127.30.118.60:40871
08:01:10.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.039436 31429 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.30.118.60:40871 every 8 connection(s)
08:01:10.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.042191 31349 server_base.cc:1193] Dumped server information to /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/data/info.pb
08:01:10.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.048969 31430 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
08:01:10.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.050772 31192 external_mini_cluster.cc:1434] Started /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu as pid 31349
08:01:10.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.051187 31192 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/master-2/wal/instance
08:01:10.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.068362 31430 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } has no permanent_uuid. Determining permanent_uuid...
08:01:10.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.094518 31430 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } has no permanent_uuid. Determining permanent_uuid...
08:01:10.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.104923 31430 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } has no permanent_uuid. Determining permanent_uuid...
08:01:10.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.121320 31430 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0: Bootstrap starting.
08:01:10.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.128175 31430 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0: Neither blocks nor log segments found. Creating new log.
08:01:10.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.130312 31430 log.cc:826] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0: Log is configured to *not* fsync() on all Append() calls
08:01:10.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.137104 31430 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0: No bootstrap required, opened a new log
08:01:10.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.157172 31430 raft_consensus.cc:359] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } }
08:01:10.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.157838 31430 raft_consensus.cc:385] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:01:10.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.158099 31430 raft_consensus.cc:740] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 0ad39eb6008b473f867899c360be64f0, State: Initialized, Role: FOLLOWER
08:01:10.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.158973 31430 consensus_queue.cc:260] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [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: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } }
08:01:10.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.161643 31439 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [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: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } } }
08:01:10.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.162245 31439 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [sys.catalog]: This master's current role is: FOLLOWER
08:01:10.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.162899 31430 sys_catalog.cc:565] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [sys.catalog]: configured and running, proceeding with master startup.
08:01:10.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:10.190668 31450 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
08:01:10.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:10.191022 31450 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
08:01:10.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.186445 31349 master_runner.cc:187] Error getting master registration for 127.30.118.62:46193: OK, instance_id { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" instance_seqno: 1783497665730359 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
08:01:10.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.208029 31349 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
08:01:10.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:10.211503 31382 tablet.cc:2406] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0: Can't schedule compaction. Clean time has not been advanced past its initial value.
08:01:10.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.408046 31439 raft_consensus.cc:493] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
08:01:10.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.408527 31439 raft_consensus.cc:515] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } }
08:01:10.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.410683 31439 leader_election.cc:290] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers e43109ca94214105a8a9f1d986d2ebac (127.30.118.62:46193), 4252c730346f45e090cd3f97d8de1fb7 (127.30.118.61:40141)
08:01:10.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.485052 31272 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 7
08:01:10.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.519068 31272 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac: Bootstrap starting.
08:01:10.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.538515 31272 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac: Neither blocks nor log segments found. Creating new log.
08:01:10.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.543788 31272 log.cc:826] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac: Log is configured to *not* fsync() on all Append() calls
08:01:10.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.555112 31272 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac: No bootstrap required, opened a new log
08:01:10.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.600440 31272 raft_consensus.cc:359] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } }
08:01:10.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.601509 31272 raft_consensus.cc:385] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:01:10.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.602101 31272 raft_consensus.cc:740] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e43109ca94214105a8a9f1d986d2ebac, State: Initialized, Role: FOLLOWER
08:01:10.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.604244 31272 consensus_queue.cc:260] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [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: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } }
08:01:10.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.618431 31455 raft_consensus.cc:493] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
08:01:10.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.622925 31272 sys_catalog.cc:565] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [sys.catalog]: configured and running, proceeding with master startup.
08:01:10.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.631287 31247 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "0ad39eb6008b473f867899c360be64f0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e43109ca94214105a8a9f1d986d2ebac" is_pre_election: true
08:01:10.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.635635 31455 raft_consensus.cc:515] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } }
08:01:10.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.639277 31455 leader_election.cc:290] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 4252c730346f45e090cd3f97d8de1fb7 (127.30.118.61:40141), 0ad39eb6008b473f867899c360be64f0 (127.30.118.60:40871)
08:01:10.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.644423 31403 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e43109ca94214105a8a9f1d986d2ebac" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0ad39eb6008b473f867899c360be64f0" is_pre_election: true
08:01:10.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.645648 31403 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate e43109ca94214105a8a9f1d986d2ebac in term 0.
08:01:10.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.641813 31247 raft_consensus.cc:2468] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 0ad39eb6008b473f867899c360be64f0 in term 0.
08:01:10.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.650638 31224 leader_election.cc:304] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [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: 0ad39eb6008b473f867899c360be64f0, e43109ca94214105a8a9f1d986d2ebac; no voters: 
08:01:10.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.662714 31455 raft_consensus.cc:2804] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 0 FOLLOWER]: Leader pre-election won for term 1
08:01:10.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.663463 31455 raft_consensus.cc:493] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
08:01:10.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.664095 31455 raft_consensus.cc:3060] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 0 FOLLOWER]: Advancing to term 1
08:01:10.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.663985 31379 leader_election.cc:304] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [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: 0ad39eb6008b473f867899c360be64f0, e43109ca94214105a8a9f1d986d2ebac; no voters: 
08:01:10.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.665001 31439 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 0 FOLLOWER]: Leader pre-election won for term 1
08:01:10.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.665371 31439 raft_consensus.cc:493] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
08:01:10.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.665702 31439 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 0 FOLLOWER]: Advancing to term 1
08:01:10.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.676280 31454 sys_catalog.cc:455] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [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: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } } }
08:01:10.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.678313 31454 sys_catalog.cc:458] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [sys.catalog]: This master's current role is: FOLLOWER
08:01:10.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.680994 31439 raft_consensus.cc:515] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } }
08:01:10.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.682947 31455 raft_consensus.cc:515] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } }
08:01:10.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:10.692350 31226 tablet.cc:2406] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac: Can't schedule compaction. Clean time has not been advanced past its initial value.
08:01:10.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.698649 31455 leader_election.cc:290] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [CANDIDATE]: Term 1 election: Requested vote from peers 4252c730346f45e090cd3f97d8de1fb7 (127.30.118.61:40141), 0ad39eb6008b473f867899c360be64f0 (127.30.118.60:40871)
08:01:10.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.699252 31247 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "0ad39eb6008b473f867899c360be64f0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e43109ca94214105a8a9f1d986d2ebac"
08:01:10.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.699322 31403 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e43109ca94214105a8a9f1d986d2ebac" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0ad39eb6008b473f867899c360be64f0"
08:01:10.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.700428 31403 raft_consensus.cc:2393] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 1 FOLLOWER]: Leader election vote request: Denying vote to candidate e43109ca94214105a8a9f1d986d2ebac in current term 1: Already voted for candidate 0ad39eb6008b473f867899c360be64f0 in this term.
08:01:10.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.700428 31247 raft_consensus.cc:2393] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 1 FOLLOWER]: Leader election vote request: Denying vote to candidate 0ad39eb6008b473f867899c360be64f0 in current term 1: Already voted for candidate e43109ca94214105a8a9f1d986d2ebac in this term.
08:01:10.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.705839 31439 leader_election.cc:290] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [CANDIDATE]: Term 1 election: Requested vote from peers e43109ca94214105a8a9f1d986d2ebac (127.30.118.62:46193), 4252c730346f45e090cd3f97d8de1fb7 (127.30.118.61:40141)
08:01:10.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:10.871711 31466 catalog_manager.cc:1594] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
08:01:10.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:10.873631 31466 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
08:01:10.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.838740 31204 master_runner.cc:187] Error getting master registration for 127.30.118.61:40141: OK, instance_id { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" instance_seqno: 1783497667582150 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
08:01:10.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:10.898785 31204 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
08:01:11.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:11.195731 31450 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
08:01:11.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:11.196518 31450 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
08:01:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:11.879307 31466 catalog_manager.cc:1594] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
08:01:11.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:11.879662 31466 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
08:01:12.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.058998 31380 proxy.cc:239] Call had error, refreshing address and retrying: Timed out: RequestConsensusVote RPC to 127.30.118.61:40141 timed out after 1.646s (SENT)
08:01:12.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.101925 31347 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } attempt: 8
08:01:12.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.141208 31347 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7: Bootstrap starting.
08:01:12.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.149991 31347 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7: Neither blocks nor log segments found. Creating new log.
08:01:12.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.152549 31347 log.cc:826] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7: Log is configured to *not* fsync() on all Append() calls
08:01:12.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.164458 31347 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7: No bootstrap required, opened a new log
08:01:12.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.193454 31347 raft_consensus.cc:359] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } }
08:01:12.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.194775 31347 raft_consensus.cc:385] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:01:12.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.195372 31347 raft_consensus.cc:740] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 4252c730346f45e090cd3f97d8de1fb7, State: Initialized, Role: FOLLOWER
08:01:12.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.200796 31450 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
08:01:12.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.201359 31450 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
08:01:12.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.196542 31347 consensus_queue.cc:260] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [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: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } }
08:01:12.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.218192 31347 sys_catalog.cc:565] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [sys.catalog]: configured and running, proceeding with master startup.
08:01:12.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.218495 31318 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "0ad39eb6008b473f867899c360be64f0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "4252c730346f45e090cd3f97d8de1fb7" is_pre_election: true
08:01:12.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.220425 31318 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 0ad39eb6008b473f867899c360be64f0 in term 0.
08:01:12.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.223019 31472 sys_catalog.cc:455] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [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: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } } }
08:01:12.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.226454 31472 sys_catalog.cc:458] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [sys.catalog]: This master's current role is: FOLLOWER
08:01:12.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.221376 31321 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e43109ca94214105a8a9f1d986d2ebac" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "4252c730346f45e090cd3f97d8de1fb7" is_pre_election: true
08:01:12.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.219415 31322 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "0ad39eb6008b473f867899c360be64f0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "4252c730346f45e090cd3f97d8de1fb7" is_pre_election: true
08:01:12.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.229034 31321 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate e43109ca94214105a8a9f1d986d2ebac in term 0.
08:01:12.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.222154 31319 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "0ad39eb6008b473f867899c360be64f0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "4252c730346f45e090cd3f97d8de1fb7"
08:01:12.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.230122 31319 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [term 0 FOLLOWER]: Advancing to term 1
08:01:12.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.231185 31321 rpcz_store.cc:267] Call kudu.consensus.ConsensusService.RequestConsensusVote from 127.0.0.1:56148 (request call id 1) took 1590 ms (client timeout 2084 ms). Trace:
08:01:12.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.234438 31322 rpcz_store.cc:267] Call kudu.consensus.ConsensusService.RequestConsensusVote from 127.0.0.1:56174 (request call id 1) took 1823 ms (client timeout 1646 ms). Trace:
08:01:12.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.234349 31321 rpcz_store.cc:269] 0708 08:01:10.640643 (+     0us) service_pool.cc:167] Inserting onto call queue
08:01:12.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 08:01:10.640850 (+   207us) service_pool.cc:224] Handling call
08:01:12.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 08:01:12.230931 (+1590081us) inbound_call.cc:177] Queueing success response
08:01:12.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {}
08:01:12.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.234848 31322 rpcz_store.cc:269] 0708 08:01:10.411488 (+     0us) service_pool.cc:167] Inserting onto call queue
08:01:12.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 08:01:10.411616 (+   128us) service_pool.cc:224] Handling call
08:01:12.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 08:01:12.234349 (+1822733us) inbound_call.cc:177] Queueing success response
08:01:12.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {}
08:01:12.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.236887 31320 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e43109ca94214105a8a9f1d986d2ebac" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "4252c730346f45e090cd3f97d8de1fb7"
08:01:12.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.237695 31320 rpcz_store.cc:275] Call kudu.consensus.ConsensusService.RequestConsensusVote from 127.0.0.1:56148 (request call id 2) took 1550 ms. Trace:
08:01:12.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.238032 31320 rpcz_store.cc:276] 0708 08:01:10.687132 (+     0us) service_pool.cc:167] Inserting onto call queue
08:01:12.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 08:01:10.687578 (+   446us) service_pool.cc:224] Handling call
08:01:12.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 08:01:12.228621 (+1541043us) spinlock_profiling.cc:243] Waited 1.3 ms on lock 0x7b5c0000ff8c. stack: 00007fb2e3617543 00007fb2e3617440 00007fb2e31c7574 000000000050ee54 000000000050ede9 00007fb2eab34fe1 00007fb2eacd68f9 00007fb2eb7c50b6 00007fb2e9e7a834 00007fb2e9e7a7c2 00007fb2e9e7a6f1 00007fb2e9e7a66c 00007fb2e9e79922 00007fb2e8463cac 00007fb2e84630e6 00007fb2e8462a8f
08:01:12.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 08:01:12.237642 (+  9021us) inbound_call.cc:177] Queueing success response
08:01:12.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"spinlock_wait_cycles":2984192}
08:01:12.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.239291 31224 leader_election.cc:304] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [CANDIDATE]: Term 1 election: Election decided. Result: candidate lost. Election summary: received 3 responses out of 3 voters: 1 yes votes; 2 no votes. yes voters: e43109ca94214105a8a9f1d986d2ebac; no voters: 0ad39eb6008b473f867899c360be64f0, 4252c730346f45e090cd3f97d8de1fb7
08:01:12.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.244782 31319 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 0ad39eb6008b473f867899c360be64f0 in term 1.
08:01:12.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.248512 31319 rpcz_store.cc:267] Call kudu.consensus.ConsensusService.RequestConsensusVote from 127.0.0.1:56174 (request call id 2) took 1543 ms (client timeout 1601 ms). Trace:
08:01:12.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.249912 31319 rpcz_store.cc:269] 0708 08:01:10.705589 (+     0us) service_pool.cc:167] Inserting onto call queue
08:01:12.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 08:01:10.705743 (+   154us) service_pool.cc:224] Handling call
08:01:12.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 08:01:12.248444 (+1542701us) inbound_call.cc:177] Queueing success response
08:01:12.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {}
08:01:12.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.256382 31380 leader_election.cc:304] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 3 responses out of 3 voters: 2 yes votes; 1 no votes. yes voters: 0ad39eb6008b473f867899c360be64f0, 4252c730346f45e090cd3f97d8de1fb7; no voters: e43109ca94214105a8a9f1d986d2ebac
08:01:12.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.271010 31476 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 1 FOLLOWER]: Leader election won for term 1
08:01:12.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.279811 31474 raft_consensus.cc:2749] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 1 FOLLOWER]: Leader election lost for term 1. Reason: could not achieve majority
08:01:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.285588 31476 raft_consensus.cc:697] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [term 1 LEADER]: Becoming Leader. State: Replica: 0ad39eb6008b473f867899c360be64f0, State: Running, Role: LEADER
08:01:12.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.287338 31476 consensus_queue.cc:237] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [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: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } }
08:01:12.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.289773 31301 tablet.cc:2406] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7: Can't schedule compaction. Clean time has not been advanced past its initial value.
08:01:12.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.313748 31478 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 0ad39eb6008b473f867899c360be64f0. Latest consensus state: current_term: 1 leader_uuid: "0ad39eb6008b473f867899c360be64f0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } } }
08:01:12.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.317605 31478 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [sys.catalog]: This master's current role is: LEADER
08:01:12.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.326049 31484 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
08:01:12.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.339826 31484 catalog_manager.cc:1520] Initializing Kudu cluster ID...
08:01:12.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.349659 31488 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
08:01:12.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.386559 31319 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [term 1 FOLLOWER]: Refusing update from remote peer 0ad39eb6008b473f867899c360be64f0: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
08:01:12.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.388217 31478 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [LEADER]: Connected to new peer: Peer: permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
08:01:12.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.402120 31247 raft_consensus.cc:1275] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [term 1 FOLLOWER]: Refusing update from remote peer 0ad39eb6008b473f867899c360be64f0: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
08:01:12.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.406039 31478 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [LEADER]: Connected to new peer: Peer: permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
08:01:12.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.424957 31489 mvcc.cc:204] Tried to move back new op lower bound from 7305206466075598848 to 7305206465711235072. Current Snapshot: MvccSnapshot[applied={T|T < 7305206466075598848}]
08:01:12.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.428001 31472 sys_catalog.cc:455] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 0ad39eb6008b473f867899c360be64f0. Latest consensus state: current_term: 1 leader_uuid: "0ad39eb6008b473f867899c360be64f0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } } }
08:01:12.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.429128 31472 sys_catalog.cc:458] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [sys.catalog]: This master's current role is: FOLLOWER
08:01:12.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.432741 31484 catalog_manager.cc:1383] Generated new cluster ID: 596db72f9de44db38731d50a6c760ccd
08:01:12.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.433027 31484 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
08:01:12.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.435773 31476 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "0ad39eb6008b473f867899c360be64f0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } } }
08:01:12.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.436460 31476 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [sys.catalog]: This master's current role is: LEADER
08:01:12.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.437141 31490 mvcc.cc:204] Tried to move back new op lower bound from 7305206466075598848 to 7305206465711235072. Current Snapshot: MvccSnapshot[applied={T|T < 7305206466075598848}]
08:01:12.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.448125 31472 sys_catalog.cc:455] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "0ad39eb6008b473f867899c360be64f0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } } }
08:01:12.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.448820 31472 sys_catalog.cc:458] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7 [sys.catalog]: This master's current role is: FOLLOWER
08:01:12.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.453092 31474 sys_catalog.cc:455] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [sys.catalog]: SysCatalogTable state changed. Reason: New leader 0ad39eb6008b473f867899c360be64f0. Latest consensus state: current_term: 1 leader_uuid: "0ad39eb6008b473f867899c360be64f0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } } }
08:01:12.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.454427 31474 sys_catalog.cc:458] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [sys.catalog]: This master's current role is: FOLLOWER
08:01:12.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.457029 31478 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "0ad39eb6008b473f867899c360be64f0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } } }
08:01:12.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.457662 31478 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0 [sys.catalog]: This master's current role is: LEADER
08:01:12.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.477622 31474 sys_catalog.cc:455] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "0ad39eb6008b473f867899c360be64f0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e43109ca94214105a8a9f1d986d2ebac" member_type: VOTER last_known_addr { host: "127.30.118.62" port: 46193 } } peers { permanent_uuid: "4252c730346f45e090cd3f97d8de1fb7" member_type: VOTER last_known_addr { host: "127.30.118.61" port: 40141 } } peers { permanent_uuid: "0ad39eb6008b473f867899c360be64f0" member_type: VOTER last_known_addr { host: "127.30.118.60" port: 40871 } } }
08:01:12.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.478335 31474 sys_catalog.cc:458] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac [sys.catalog]: This master's current role is: FOLLOWER
08:01:12.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.485963 31484 catalog_manager.cc:1406] Generated new certificate authority record
08:01:12.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.489322 31484 catalog_manager.cc:1540] Loading token signing keys...
08:01:12.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.530866 31484 catalog_manager.cc:6070] T 00000000000000000000000000000000 P 0ad39eb6008b473f867899c360be64f0: Generated new TSK 0
08:01:12.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.532557 31484 catalog_manager.cc:1550] Initializing in-progress tserver states...
08:01:12.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.570711 31192 external_mini_cluster.cc:1372] Running /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:12.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:12.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/wal
08:01:12.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/data
08:01:12.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:01:12.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:01:12.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:01:12.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:12.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:12.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:12.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/logs
08:01:12.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/data/info.pb
08:01:12.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:12.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:01:12.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:01:12.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:01:12.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:01:12.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:12.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:12.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:12.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
08:01:12.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:01:12.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.1:0
08:01:12.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.30.118.1
08:01:12.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.1
08:01:12.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:12.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:12.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:12.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:12.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:12.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
08:01:12.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.885286 31466 catalog_manager.cc:1295] Loaded cluster ID: 596db72f9de44db38731d50a6c760ccd
08:01:12.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.886432 31466 catalog_manager.cc:1588] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac: loading cluster ID for follower catalog manager: success
08:01:12.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.894177 31466 catalog_manager.cc:1610] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac: acquiring CA information for follower catalog manager: success
08:01:12.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:12.900264 31466 catalog_manager.cc:1638] T 00000000000000000000000000000000 P e43109ca94214105a8a9f1d986d2ebac: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
08:01:12.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.971354 31498 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:01:12.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.971978 31498 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:01:12.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:12.972625 31498 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:01:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:13.013238 31498 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:01:13.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:13.014318 31498 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.30.118.1
08:01:13.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:13.086416 31498 tablet_server_runner.cc:78] Tablet server non-default flags:
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/data
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/wal
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.1:0
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/data/info.pb
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.1
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.30.118.1
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/logs
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 07:43:22 UTC on e7f111948823
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12771
08:01:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:01:13.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:13.090379 31498 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:01:13.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:13.093004 31498 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:01:13.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:13.126412 31504 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
08:01:13.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:13.361599 31488 catalog_manager.cc:1295] Loaded cluster ID: 596db72f9de44db38731d50a6c760ccd
08:01:13.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:13.362334 31488 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7: loading cluster ID for follower catalog manager: success
08:01:13.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:13.370750 31488 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7: acquiring CA information for follower catalog manager: success
08:01:13.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:13.377074 31488 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 4252c730346f45e090cd3f97d8de1fb7: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
08:01:14.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:13.141013 31508 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
08:01:14.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:13.141491 31505 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
08:01:14.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:13.141958 31498 server_base.cc:1061] running on GCE node
08:01:14.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.517153 31498 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:01:14.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.520360 31498 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:01:14.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.522117 31498 hybrid_clock.cc:648] HybridClock initialized: now 1783497674522076 us; error 55 us; skew 500 ppm
08:01:14.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.523043 31498 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:01:14.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.531507 31498 webserver.cc:533] Webserver started at http://127.30.118.1:45053/ using document root <none> and password file <none>
08:01:14.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.532500 31498 fs_manager.cc:362] Metadata directory not provided
08:01:14.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.532744 31498 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:01:14.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.533277 31498 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:01:14.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.538185 31498 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/data/instance:
08:01:14.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1a5427746b6b4757b1157b40bb462332"
08:01:14.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:14 on dist-test-slave-j0xp"
08:01:14.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.539429 31498 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/wal/instance:
08:01:14.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1a5427746b6b4757b1157b40bb462332"
08:01:14.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:14 on dist-test-slave-j0xp"
08:01:14.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.547049 31498 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.007s	sys 0.001s
08:01:14.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.553180 31517 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:01:14.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.554567 31498 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.000s
08:01:14.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.554877 31498 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/data,/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/wal
08:01:14.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1a5427746b6b4757b1157b40bb462332"
08:01:14.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:14 on dist-test-slave-j0xp"
08:01:14.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.555173 31498 fs_report.cc:389] FS layout report
08:01:14.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:01:14.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/wal
08:01:14.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/wal
08:01:14.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/data/data
08:01:14.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:01:14.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:01:14.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:01:14.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:01:14.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:01:14.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:01:14.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:01:14.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:01:14.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:01:14.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:01:14.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:01:14.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.603595 31498 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:01:14.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.605345 31498 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:01:14.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.605890 31498 kserver.cc:163] Server-wide thread pool size limit: 3276
08:01:14.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.609371 31498 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
08:01:14.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.614521 31498 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
08:01:14.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.614933 31498 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.001s	sys 0.000s
08:01:14.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.615226 31498 ts_tablet_manager.cc:616] Registered 0 tablets
08:01:14.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.615435 31498 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
08:01:14.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.813395 31498 rpc_server.cc:307] RPC server started. Bound to: 127.30.118.1:36025
08:01:14.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.813565 31629 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.30.118.1:36025 every 8 connection(s)
08:01:14.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.816246 31498 server_base.cc:1193] Dumped server information to /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/data/info.pb
08:01:14.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.819693 31192 external_mini_cluster.cc:1434] Started /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu as pid 31498
08:01:14.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.820325 31192 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-0/wal/instance
08:01:14.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.837009 31192 external_mini_cluster.cc:1372] Running /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:14.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:14.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/wal
08:01:14.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/data
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/logs
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/data/info.pb
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:01:14.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.2:0
08:01:14.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.30.118.2
08:01:14.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.2
08:01:14.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:14.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:14.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:14.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:14.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:14.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
08:01:14.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.904699 31631 heartbeater.cc:344] Connected to a master server at 127.30.118.61:40141
08:01:14.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.905297 31631 heartbeater.cc:461] Registering TS with master...
08:01:14.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.906791 31630 heartbeater.cc:344] Connected to a master server at 127.30.118.60:40871
08:01:14.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.906898 31631 heartbeater.cc:507] Master 127.30.118.61:40141 requested a full tablet report, sending...
08:01:14.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.907200 31630 heartbeater.cc:461] Registering TS with master...
08:01:14.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.908145 31630 heartbeater.cc:507] Master 127.30.118.60:40871 requested a full tablet report, sending...
08:01:14.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.912148 31393 ts_manager.cc:194] Registered new tserver with Master: 1a5427746b6b4757b1157b40bb462332 (127.30.118.1:36025)
08:01:14.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.912379 31312 ts_manager.cc:194] Registered new tserver with Master: 1a5427746b6b4757b1157b40bb462332 (127.30.118.1:36025)
08:01:14.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.915330 31393 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.30.118.1:56835
08:01:14.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.921509 31635 heartbeater.cc:344] Connected to a master server at 127.30.118.62:46193
08:01:14.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.921932 31635 heartbeater.cc:461] Registering TS with master...
08:01:14.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.922521 31635 heartbeater.cc:507] Master 127.30.118.62:46193 requested a full tablet report, sending...
08:01:14.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:14.925356 31237 ts_manager.cc:194] Registered new tserver with Master: 1a5427746b6b4757b1157b40bb462332 (127.30.118.1:36025)
08:01:15.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:15.240165 31634 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:01:15.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:15.240948 31634 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:01:15.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:15.241539 31634 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:01:15.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:15.274034 31634 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:01:15.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:15.275018 31634 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.30.118.2
08:01:15.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:15.312016 31634 tablet_server_runner.cc:78] Tablet server non-default flags:
08:01:15.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:15.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:15.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:15.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:01:15.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/data
08:01:15.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/wal
08:01:15.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:15.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:15.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.2:0
08:01:15.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:01:15.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:15.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/data/info.pb
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.2
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.30.118.2
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/logs
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 07:43:22 UTC on e7f111948823
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12771
08:01:15.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:01:15.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:15.315939 31634 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:01:15.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:15.318122 31634 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:01:15.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:15.333904 31646 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
08:01:15.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:15.919497 31630 heartbeater.cc:499] Master 127.30.118.60:40871 was elected leader, sending a full tablet report...
08:01:16.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:15.334355 31647 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
08:01:16.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:16.655678 31634 thread.cc:641] GCE (cloud detector) Time spent creating pthread: real 1.324s	user 0.486s	sys 0.817s
08:01:16.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:16.656360 31634 thread.cc:608] GCE (cloud detector) Time spent starting thread: real 1.325s	user 0.487s	sys 0.818s
08:01:16.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.658321 31634 server_base.cc:1061] running on GCE node
08:01:16.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:16.659907 31654 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
08:01:16.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.661034 31634 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:01:16.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.663542 31634 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:01:16.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.665150 31634 hybrid_clock.cc:648] HybridClock initialized: now 1783497676665112 us; error 41 us; skew 500 ppm
08:01:16.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.666296 31634 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:01:16.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.677493 31634 webserver.cc:533] Webserver started at http://127.30.118.2:41963/ using document root <none> and password file <none>
08:01:16.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.678552 31634 fs_manager.cc:362] Metadata directory not provided
08:01:16.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.678815 31634 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:01:16.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.679381 31634 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:01:16.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.683933 31634 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/data/instance:
08:01:16.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9e9f1d321625455c8bf78ed5b3cff239"
08:01:16.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:16 on dist-test-slave-j0xp"
08:01:16.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.685227 31634 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/wal/instance:
08:01:16.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9e9f1d321625455c8bf78ed5b3cff239"
08:01:16.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:16 on dist-test-slave-j0xp"
08:01:16.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.693945 31634 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.006s	sys 0.001s
08:01:16.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.700094 31659 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:01:16.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.701318 31634 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.006s	sys 0.000s
08:01:16.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.701692 31634 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/data,/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/wal
08:01:16.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9e9f1d321625455c8bf78ed5b3cff239"
08:01:16.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:16 on dist-test-slave-j0xp"
08:01:16.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.702097 31634 fs_report.cc:389] FS layout report
08:01:16.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:01:16.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/wal
08:01:16.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/wal
08:01:16.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/data/data
08:01:16.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:01:16.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:01:16.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:01:16.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:01:16.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:01:16.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:01:16.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:01:16.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:01:16.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:01:16.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:01:16.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:01:16.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.777666 31634 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:01:16.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.779515 31634 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:01:16.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.780251 31634 kserver.cc:163] Server-wide thread pool size limit: 3276
08:01:16.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.783543 31634 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
08:01:16.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.787894 31634 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
08:01:16.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.788133 31634 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
08:01:16.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.788427 31634 ts_tablet_manager.cc:616] Registered 0 tablets
08:01:16.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.788635 31634 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
08:01:16.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.943647 31634 rpc_server.cc:307] RPC server started. Bound to: 127.30.118.2:43907
08:01:16.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.943759 31771 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.30.118.2:43907 every 8 connection(s)
08:01:16.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.946365 31634 server_base.cc:1193] Dumped server information to /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/data/info.pb
08:01:16.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.954124 31192 external_mini_cluster.cc:1434] Started /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu as pid 31634
08:01:16.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.954711 31192 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-1/wal/instance
08:01:16.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.970342 31192 external_mini_cluster.cc:1372] Running /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/wal
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/data
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/logs
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/data/info.pb
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:01:16.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:16.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:16.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:16.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
08:01:16.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:01:16.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.3:0
08:01:16.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.30.118.3
08:01:16.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.3
08:01:16.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:16.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:16.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:16.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:16.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:16.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
08:01:16.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.991303 31772 heartbeater.cc:344] Connected to a master server at 127.30.118.60:40871
08:01:16.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.991818 31772 heartbeater.cc:461] Registering TS with master...
08:01:16.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.993240 31772 heartbeater.cc:507] Master 127.30.118.60:40871 requested a full tablet report, sending...
08:01:16.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.996802 31774 heartbeater.cc:344] Connected to a master server at 127.30.118.62:46193
08:01:16.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.997014 31393 ts_manager.cc:194] Registered new tserver with Master: 9e9f1d321625455c8bf78ed5b3cff239 (127.30.118.2:43907)
08:01:16.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.997171 31774 heartbeater.cc:461] Registering TS with master...
08:01:16.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.997498 31773 heartbeater.cc:344] Connected to a master server at 127.30.118.61:40141
08:01:16.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.997859 31773 heartbeater.cc:461] Registering TS with master...
08:01:16.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.998190 31774 heartbeater.cc:507] Master 127.30.118.62:46193 requested a full tablet report, sending...
08:01:16.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.998696 31773 heartbeater.cc:507] Master 127.30.118.61:40141 requested a full tablet report, sending...
08:01:16.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:16.998840 31393 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.30.118.2:49401
08:01:17.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:17.001096 31237 ts_manager.cc:194] Registered new tserver with Master: 9e9f1d321625455c8bf78ed5b3cff239 (127.30.118.2:43907)
08:01:17.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:17.001569 31312 ts_manager.cc:194] Registered new tserver with Master: 9e9f1d321625455c8bf78ed5b3cff239 (127.30.118.2:43907)
08:01:17.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:17.302105 31782 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:01:17.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:17.302657 31782 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:01:17.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:17.303236 31782 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:01:17.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:17.339010 31782 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:01:17.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:17.339932 31782 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.30.118.3
08:01:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:17.377125 31782 tablet_server_runner.cc:78] Tablet server non-default flags:
08:01:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:01:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.30.118.20:43753
08:01:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:01:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:01:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/data
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/wal
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.30.118.3:0
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/data/info.pb
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.30.118.3
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.30.118.62:46193,127.30.118.61:40141,127.30.118.60:40871
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.30.118.3
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/logs
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 07:43:22 UTC on e7f111948823
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12771
08:01:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:01:17.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:17.378850 31782 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:01:17.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:17.380590 31782 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:01:17.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:17.394352 31788 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
08:01:18.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.004065 31772 heartbeater.cc:499] Master 127.30.118.60:40871 was elected leader, sending a full tablet report...
08:01:18.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:17.395331 31789 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
08:01:18.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:18.798199 31787 debug-util.cc:398] Leaking SignalData structure 0x7b0800028000 after lost signal to thread 31782
08:01:18.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:18.897938 31782 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.503s	user 0.546s	sys 0.931s
08:01:18.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:18.898942 31782 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.505s	user 0.546s	sys 0.931s
08:01:18.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:18.900374 31791 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
08:01:18.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 08:01:18.902920 31790 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1502 milliseconds
08:01:18.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.902962 31782 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
08:01:18.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.904166 31782 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:01:18.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.906203 31782 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:01:18.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.907634 31782 hybrid_clock.cc:648] HybridClock initialized: now 1783497678907593 us; error 38 us; skew 500 ppm
08:01:18.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.908658 31782 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:01:18.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.915292 31782 webserver.cc:533] Webserver started at http://127.30.118.3:40679/ using document root <none> and password file <none>
08:01:18.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.916138 31782 fs_manager.cc:362] Metadata directory not provided
08:01:18.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.916329 31782 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:01:18.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.916685 31782 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:01:18.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.920811 31782 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/data/instance:
08:01:18.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2e14410a2890474d9d728112e4d9670d"
08:01:18.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:18 on dist-test-slave-j0xp"
08:01:18.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.921909 31782 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/wal/instance:
08:01:18.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2e14410a2890474d9d728112e4d9670d"
08:01:18.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:18 on dist-test-slave-j0xp"
08:01:18.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.929034 31782 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.005s	sys 0.001s
08:01:18.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.934945 31799 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:01:18.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.936437 31782 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.000s	sys 0.005s
08:01:18.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.936842 31782 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/data,/tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/wal
08:01:18.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2e14410a2890474d9d728112e4d9670d"
08:01:18.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 08:01:18 on dist-test-slave-j0xp"
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.937305 31782 fs_report.cc:389] FS layout report
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/wal
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/wal
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/data/data
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:01:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:01:18.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.997553 31782 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:01:18.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.999083 31782 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:01:18.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:18.999471 31782 kserver.cc:163] Server-wide thread pool size limit: 3276
08:01:19.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.002562 31782 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
08:01:19.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.006656 31782 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
08:01:19.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.006853 31782 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
08:01:19.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.007045 31782 ts_tablet_manager.cc:616] Registered 0 tablets
08:01:19.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.007176 31782 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
08:01:19.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.349041 31782 rpc_server.cc:307] RPC server started. Bound to: 127.30.118.3:42833
08:01:19.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.349303 31911 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.30.118.3:42833 every 8 connection(s)
08:01:19.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.353569 31782 server_base.cc:1193] Dumped server information to /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/data/info.pb
08:01:19.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.363070 31192 external_mini_cluster.cc:1434] Started /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu as pid 31782
08:01:19.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.363634 31192 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task4PYGkC/test-tmp/mini-kudu-cluster659026218351904199/ts-2/wal/instance
08:01:19.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.418608 31913 heartbeater.cc:344] Connected to a master server at 127.30.118.61:40141
08:01:19.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.419181 31913 heartbeater.cc:461] Registering TS with master...
08:01:19.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.420568 31913 heartbeater.cc:507] Master 127.30.118.61:40141 requested a full tablet report, sending...
08:01:19.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.424202 31312 ts_manager.cc:194] Registered new tserver with Master: 2e14410a2890474d9d728112e4d9670d (127.30.118.3:42833)
08:01:19.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.426156 31912 heartbeater.cc:344] Connected to a master server at 127.30.118.60:40871
08:01:19.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.426630 31912 heartbeater.cc:461] Registering TS with master...
08:01:19.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.427932 31912 heartbeater.cc:507] Master 127.30.118.60:40871 requested a full tablet report, sending...
08:01:19.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.429913 31914 heartbeater.cc:344] Connected to a master server at 127.30.118.62:46193
08:01:19.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.430301 31914 heartbeater.cc:461] Registering TS with master...
08:01:19.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.430708 31393 ts_manager.cc:194] Registered new tserver with Master: 2e14410a2890474d9d728112e4d9670d (127.30.118.3:42833)
08:01:19.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.431501 31914 heartbeater.cc:507] Master 127.30.118.62:46193 requested a full tablet report, sending...
08:01:19.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.432713 31393 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.30.118.3:33111
08:01:19.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.434959 31237 ts_manager.cc:194] Registered new tserver with Master: 2e14410a2890474d9d728112e4d9670d (127.30.118.3:42833)
08:01:19.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:19.445715 31192 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
08:01:19.461 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
08:01:19.462 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

08:01:19.472 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.30.118.62"
      port: 46193
    }
    bound_http_address {
      host: "127.30.118.62"
      port: 44061
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.30.118.61"
      port: 40141
    }
    bound_http_address {
      host: "127.30.118.61"
      port: 44531
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.30.118.60"
      port: 40871
    }
    bound_http_address {
      host: "127.30.118.60"
      port: 40029
    }
  }
}

08:01:19.475 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

08:01:19.478 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.30.118.1"
      port: 36025
    }
    bound_http_address {
      host: "127.30.118.1"
      port: 45053
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.30.118.2"
      port: 43907
    }
    bound_http_address {
      host: "127.30.118.2"
      port: 41963
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.30.118.3"
      port: 42833
    }
    bound_http_address {
      host: "127.30.118.3"
      port: 40679
    }
  }
}

08:01:19.478 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
08:01:19.672 [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)
08:01:19.734 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
08:01:19.917 [DEBUG - main] (Connection.java:748) [peer master-127.30.118.60:40871(127.30.118.60:40871)] connecting to peer
08:01:19.968 [DEBUG - main] (Connection.java:748) [peer master-127.30.118.62:46193(127.30.118.62:46193)] connecting to peer
08:01:19.969 [DEBUG - main] (Connection.java:748) [peer master-127.30.118.61:40141(127.30.118.61:40141)] connecting to peer
08:01:19.987 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.30.118.61:40141(127.30.118.61:40141)] Successfully connected to peer
08:01:19.991 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.30.118.60:40871(127.30.118.60:40871)] Successfully connected to peer
08:01:19.993 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.30.118.62:46193(127.30.118.62:46193)] Successfully connected to peer
08:01:20.092 [DEBUG - kudu-nio-2] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.30.118.61
08:01:20.092 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.30.118.60
08:01:20.098 [DEBUG - kudu-nio-1] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.30.118.62
08:01:20.311 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0x55abc6d6, L:/127.0.0.1:41326 - R:/127.30.118.60:40871] using SASL/PLAIN
08:01:20.311 [DEBUG - kudu-nio-2] (Negotiator.java:918) Authenticated connection [id: 0x3b294d15, L:/127.0.0.1:48932 - R:/127.30.118.61:40141] using SASL/PLAIN
08:01:20.311 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0x576222f7, L:/127.0.0.1:54002 - R:/127.30.118.62:46193] using SASL/PLAIN
08:01:20.347 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
08:01:20.348 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=468), Traces: [0ms] refreshing cache from master, [22ms] Sub RPC ConnectToMaster: sending RPC to server master-127.30.118.60:40871, [84ms] Sub RPC ConnectToMaster: sending RPC to server master-127.30.118.62:46193, [85ms] Sub RPC ConnectToMaster: sending RPC to server master-127.30.118.61:40141, [442ms] Sub RPC ConnectToMaster: received response from server master-127.30.118.62:46193: OK, [442ms] Sub RPC ConnectToMaster: received response from server master-127.30.118.61:40141: OK, [442ms] Sub RPC ConnectToMaster: received response from server master-127.30.118.60:40871: OK, deferred=null) after lookup
08:01:20.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.399639 31393 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:41326:
08:01:20.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestStatistics-1783497662012"
08:01:20.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
08:01:20.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
08:01:20.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
08:01:20.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
08:01:20.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
08:01:20.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
08:01:20.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
08:01:20.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
08:01:20.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
08:01:20.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
08:01:20.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
08:01:20.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
08:01:20.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
08:01:20.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
08:01:20.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
08:01:20.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
08:01:20.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
08:01:20.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
08:01:20.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
08:01:20.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
08:01:20.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
08:01:20.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
08:01:20.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
08:01:20.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
08:01:20.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
08:01:20.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
08:01:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.438493 31912 heartbeater.cc:499] Master 127.30.118.60:40871 was elected leader, sending a full tablet report...
08:01:20.501 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 582450aad61a44b2bc1f5ede8b9dba11
08:01:20.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.513975 31707 tablet_service.cc:1511] Processing CreateTablet for tablet 68d7c13e4d9b4030912d1a88c76fcd17 (DEFAULT_TABLE table=org.apache.kudu.client.TestStatistics-1783497662012 [id=582450aad61a44b2bc1f5ede8b9dba11]), partition=RANGE (key) PARTITION UNBOUNDED
08:01:20.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.515338 31707 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 68d7c13e4d9b4030912d1a88c76fcd17. 1 dirs total, 0 dirs full, 0 dirs failed
08:01:20.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.541472 31942 tablet_bootstrap.cc:492] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239: Bootstrap starting.
08:01:20.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.548185 31942 tablet_bootstrap.cc:654] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239: Neither blocks nor log segments found. Creating new log.
08:01:20.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.550055 31942 log.cc:826] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239: Log is configured to *not* fsync() on all Append() calls
08:01:20.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.554960 31942 tablet_bootstrap.cc:492] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239: No bootstrap required, opened a new log
08:01:20.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.555482 31942 ts_tablet_manager.cc:1403] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239: Time spent bootstrapping tablet: real 0.015s	user 0.004s	sys 0.008s
08:01:20.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.574749 31942 raft_consensus.cc:359] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "9e9f1d321625455c8bf78ed5b3cff239" member_type: VOTER last_known_addr { host: "127.30.118.2" port: 43907 } }
08:01:20.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.575366 31942 raft_consensus.cc:385] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:01:20.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.575632 31942 raft_consensus.cc:740] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 9e9f1d321625455c8bf78ed5b3cff239, State: Initialized, Role: FOLLOWER
08:01:20.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.576941 31942 consensus_queue.cc:260] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [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: true peers { permanent_uuid: "9e9f1d321625455c8bf78ed5b3cff239" member_type: VOTER last_known_addr { host: "127.30.118.2" port: 43907 } }
08:01:20.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.577616 31942 raft_consensus.cc:399] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
08:01:20.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.578019 31942 raft_consensus.cc:493] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
08:01:20.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.578416 31942 raft_consensus.cc:3060] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [term 0 FOLLOWER]: Advancing to term 1
08:01:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.582727 31942 raft_consensus.cc:515] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "9e9f1d321625455c8bf78ed5b3cff239" member_type: VOTER last_known_addr { host: "127.30.118.2" port: 43907 } }
08:01:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.583608 31942 leader_election.cc:304] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: 9e9f1d321625455c8bf78ed5b3cff239; no voters: 
08:01:20.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.585616 31942 leader_election.cc:290] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [CANDIDATE]: Term 1 election: Requested vote from peers 
08:01:20.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.586097 31944 raft_consensus.cc:2804] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [term 1 FOLLOWER]: Leader election won for term 1
08:01:20.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.589300 31944 raft_consensus.cc:697] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [term 1 LEADER]: Becoming Leader. State: Replica: 9e9f1d321625455c8bf78ed5b3cff239, State: Running, Role: LEADER
08:01:20.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.590483 31942 ts_tablet_manager.cc:1434] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239: Time spent starting tablet: real 0.035s	user 0.032s	sys 0.004s
08:01:20.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.590408 31944 consensus_queue.cc:237] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 [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: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "9e9f1d321625455c8bf78ed5b3cff239" member_type: VOTER last_known_addr { host: "127.30.118.2" port: 43907 } }
08:01:20.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:20.603729 31393 catalog_manager.cc:5697] T 68d7c13e4d9b4030912d1a88c76fcd17 P 9e9f1d321625455c8bf78ed5b3cff239 reported cstate change: term changed from 0 to 1, leader changed from <none> to 9e9f1d321625455c8bf78ed5b3cff239 (127.30.118.2). New cstate: current_term: 1 leader_uuid: "9e9f1d321625455c8bf78ed5b3cff239" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "9e9f1d321625455c8bf78ed5b3cff239" member_type: VOTER last_known_addr { host: "127.30.118.2" port: 43907 } health_report { overall_health: HEALTHY } } }
08:01:20.666 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@13191185(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:01:20.668 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 68d7c13e4d9b4030912d1a88c76fcd17 for table 'org.apache.kudu.client.TestStatistics-1783497662012' with partition [<start>, <end>)
08:01:20.674 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=68d7c13e4d9b4030912d1a88c76fcd17@[9e9f1d321625455c8bf78ed5b3cff239(127.30.118.2:43907)[L]]}]
08:01:20.676 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 68d7c13e4d9b4030912d1a88c76fcd17 for table 'org.apache.kudu.client.TestStatistics-1783497662012' with partition [<start>, <end>)
08:01:20.677 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=68d7c13e4d9b4030912d1a88c76fcd17@[9e9f1d321625455c8bf78ed5b3cff239(127.30.118.2:43907)[L]]}]
08:01:20.687 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 9e9f1d321625455c8bf78ed5b3cff239(127.30.118.2:43907)] connecting to peer
08:01:20.690 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 9e9f1d321625455c8bf78ed5b3cff239(127.30.118.2:43907)] Successfully connected to peer
08:01:20.775 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0x765c2011, L:/127.0.0.1:36718 - R:/127.30.118.2:43907] using TOKEN/null
08:01:20.832 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@2113677893(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:01:20.845 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@935291947(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:01:20.856 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1913266391(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:01:20.867 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1454011621(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:01:20.879 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1251529335(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:01:20.891 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@101327163(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:01:20.901 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@623224245(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:01:20.913 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@539877544(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:01:20.923 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@740988336(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:01:21.177 [DEBUG - main] (Connection.java:575) [peer master-127.30.118.62:46193(127.30.118.62:46193)] disconnecting while in state READY
08:01:21.178 [DEBUG - main] (Connection.java:575) [peer master-127.30.118.61:40141(127.30.118.61:40141)] disconnecting while in state READY
08:01:21.178 [DEBUG - main] (Connection.java:575) [peer 9e9f1d321625455c8bf78ed5b3cff239(127.30.118.2:43907)] disconnecting while in state READY
08:01:21.178 [DEBUG - main] (Connection.java:575) [peer master-127.30.118.60:40871(127.30.118.60:40871)] disconnecting while in state READY
08:01:21.183 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
08:01:21.183 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.30.118.60:40871(127.30.118.60:40871)] handling channelInactive
08:01:21.183 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.30.118.61:40141(127.30.118.61:40141)] handling channelInactive
08:01:21.183 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.30.118.62:46193(127.30.118.62:46193)] handling channelInactive
08:01:21.184 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.30.118.61:40141(127.30.118.61:40141)] cleaning up while in state READY due to: connection closed
08:01:21.184 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.30.118.62:46193(127.30.118.62:46193)] cleaning up while in state READY due to: connection closed
08:01:21.185 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.30.118.60:40871(127.30.118.60:40871)] cleaning up while in state READY due to: connection closed
08:01:21.188 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 9e9f1d321625455c8bf78ed5b3cff239(127.30.118.2:43907)] handling channelInactive
08:01:21.189 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 9e9f1d321625455c8bf78ed5b3cff239(127.30.118.2:43907)] cleaning up while in state READY due to: connection closed
08:01:21.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:21.189270 31192 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu with pid 31498
08:01:21.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:21.222110 31192 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu with pid 31634
08:01:21.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:21.253939 31192 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu with pid 31782
08:01:21.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:21.277633 31192 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu with pid 31204
08:01:21.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:21.303588 31192 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu with pid 31274
08:01:21.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 08:01:21.332202 31192 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task4PYGkC/build/tsan/bin/kudu with pid 31349
08:01:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T08:01:22Z chronyd exiting

Time: 21.586

OK (1 test)

