JUnit version 4.13.2
.15:57:24.083 [INFO - main] (RandomUtils.java:49) Using random seed: 1783526244078
15:57:24.101 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
15:57:24.156 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
15:57:24.164 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskzQ3kQc/test-tmp
15:57:24.167 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
15:57:24.171 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskzQ3kQc/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
15:57:24.380 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

15:57:24.393 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
15:57:24.394 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

15:57:24.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.396273 13838 mini_oidc.cc:152] Starting JWKS server
15:57:24.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.398568 13838 webserver.cc:460] Webserver started at http://127.0.0.1:44143/ using document root <none> and password file <none>
15:57:24.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.398813 13838 mini_oidc.cc:189] Starting OIDC Discovery server
15:57:24.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.399163 13838 webserver.cc:460] Webserver started at http://127.0.0.1:44193/ using document root <none> and password file <none>
15:57:24.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T15:57:24Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
15:57:24.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T15:57:24Z Disabled control of system clock
15:57:24.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.419168 13838 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:24.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:24.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/wal
15:57:24.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/data
15:57:24.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:24.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:24.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:24.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/logs
15:57:24.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/data/info.pb
15:57:24.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:24.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:24.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:24.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.190:44151
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.190
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:24.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:24.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44143/jwks.json with env {}
15:57:24.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.540198 13849 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:24.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.540504 13849 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:24.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.540544 13849 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:24.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.544965 13849 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
15:57:24.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.545035 13849 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:24.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.545055 13849 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
15:57:24.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.545071 13849 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
15:57:24.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.545087 13849 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
15:57:24.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.545101 13849 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:44143/jwks.json
15:57:24.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.550129 13849 master_runner.cc:386] Master server non-default flags:
15:57:24.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:24.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/data
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/wal
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.190:44151
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44143/jwks.json
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/data/info.pb
15:57:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.190
15:57:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13849
15:57:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/logs
15:57:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
15:57:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 15:02:02 UTC on ccycloud.quasar-faqpgf.root.comops.site
15:57:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:24.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.551484 13849 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:57:24.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.552829 13849 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:24.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.562484 13849 server_base.cc:1034] running on GCE node
15:57:24.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.562463 13855 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
15:57:24.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.562572 13854 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
15:57:24.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.562513 13857 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
15:57:24.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.564102 13849 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:24.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.565536 13849 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:24.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.566911 13849 hybrid_clock.cc:648] HybridClock initialized: now 1783526244566759 us; error 172 us; skew 500 ppm
15:57:24.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.573405 13849 webserver.cc:460] Webserver started at http://127.13.131.190:37697/ using document root <none> and password file <none>
15:57:24.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.574086 13849 fs_manager.cc:359] Metadata directory not provided
15:57:24.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.574162 13849 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:24.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.574347 13849 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:24.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.576624 13849 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/data/instance:
15:57:24.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3d445944fe9442758ba226baf53a2bb3"
15:57:24.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-h1mp"
15:57:24.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.577206 13849 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/wal/instance:
15:57:24.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3d445944fe9442758ba226baf53a2bb3"
15:57:24.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-h1mp"
15:57:24.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.581303 13849 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
15:57:24.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.583995 13863 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:57:24.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.585513 13849 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.000s
15:57:24.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.585642 13849 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/data,/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/wal
15:57:24.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3d445944fe9442758ba226baf53a2bb3"
15:57:24.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-h1mp"
15:57:24.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.585731 13849 fs_report.cc:383] FS layout report
15:57:24.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:24.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/wal
15:57:24.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/wal
15:57:24.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/data/data
15:57:24.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:24.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:24.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:24.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:24.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:24.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:24.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:24.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:24.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:24.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:24.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:24.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.607272 13849 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:24.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.608028 13849 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
15:57:24.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.608181 13849 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:24.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.615252 13849 rpc_server.cc:307] RPC server started. Bound to: 127.13.131.190:44151
15:57:24.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.615274 13915 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.13.131.190:44151 every 8 connection(s)
15:57:24.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.616143 13849 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/data/info.pb
15:57:24.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.617718 13838 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu as pid 13849
15:57:24.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.617856 13838 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-0/wal/instance
15:57:24.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.619308 13838 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:24.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:24.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/wal
15:57:24.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/data
15:57:24.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:24.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/logs
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/data/info.pb
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.189:41587
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.189
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:24.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44143/jwks.json with env {}
15:57:24.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.619697 13916 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
15:57:24.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.624064 13916 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.636999 13916 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.637902 13865 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.131.189:41587: connect: Connection refused (error 111)
15:57:24.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.639109 13916 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.13.131.189:41587: Network error: Client connection negotiation failed: client connection to 127.13.131.189:41587: connect: Connection refused (error 111)
15:57:24.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.688426 13916 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } attempt: 1
15:57:24.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.690115 13916 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.13.131.189:41587: Network error: Client connection negotiation failed: client connection to 127.13.131.189:41587: connect: Connection refused (error 111)
15:57:24.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.739502 13918 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:24.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.739823 13918 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:24.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.739862 13918 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:24.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.744228 13918 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
15:57:24.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.744297 13918 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:24.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.744315 13918 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
15:57:24.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.744331 13918 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
15:57:24.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.744349 13918 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
15:57:24.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.744361 13918 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:44143/jwks.json
15:57:24.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.749480 13918 master_runner.cc:386] Master server non-default flags:
15:57:24.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:24.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/data
15:57:24.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/wal
15:57:24.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:24.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.189:41587
15:57:24.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:24.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44143/jwks.json
15:57:24.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/data/info.pb
15:57:24.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.189
15:57:24.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:24.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13918
15:57:24.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:24.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:24.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/logs
15:57:24.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:24.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:24.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
15:57:24.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:24.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:24.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:24.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 15:02:02 UTC on ccycloud.quasar-faqpgf.root.comops.site
15:57:24.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:24.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.750725 13918 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:57:24.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.752229 13918 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:24.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.758294 13916 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } attempt: 2
15:57:24.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.759719 13916 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.13.131.189:41587: Network error: Client connection negotiation failed: client connection to 127.13.131.189:41587: connect: Connection refused (error 111)
15:57:24.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.762025 13926 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
15:57:24.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.762143 13918 server_base.cc:1034] running on GCE node
15:57:24.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.762023 13927 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
15:57:24.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.762046 13929 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
15:57:24.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.763087 13918 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:24.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.764353 13918 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:24.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.765766 13918 hybrid_clock.cc:648] HybridClock initialized: now 1783526244765728 us; error 34 us; skew 500 ppm
15:57:24.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.768414 13918 webserver.cc:460] Webserver started at http://127.13.131.189:33911/ using document root <none> and password file <none>
15:57:24.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.769126 13918 fs_manager.cc:359] Metadata directory not provided
15:57:24.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.769233 13918 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:24.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.769506 13918 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:24.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.771795 13918 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/data/instance:
15:57:24.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8228dfebede64ba28952e5a0d96ba6ee"
15:57:24.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-h1mp"
15:57:24.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.772534 13918 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/wal/instance:
15:57:24.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8228dfebede64ba28952e5a0d96ba6ee"
15:57:24.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-h1mp"
15:57:24.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.777120 13918 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
15:57:24.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.780189 13935 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:57:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.781911 13918 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.000s
15:57:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.782068 13918 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/data,/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/wal
15:57:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8228dfebede64ba28952e5a0d96ba6ee"
15:57:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-h1mp"
15:57:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.782198 13918 fs_report.cc:383] FS layout report
15:57:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/wal
15:57:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/wal
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/data/data
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:24.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:24.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.797358 13918 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:24.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.798182 13918 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
15:57:24.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.798547 13918 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:24.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.807258 13918 rpc_server.cc:307] RPC server started. Bound to: 127.13.131.189:41587
15:57:24.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.808187 13987 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.13.131.189:41587 every 8 connection(s)
15:57:24.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.809105 13918 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/data/info.pb
15:57:24.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.812496 13988 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
15:57:24.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.816303 13988 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.817008 13838 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu as pid 13918
15:57:24.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.817101 13838 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-1/wal/instance
15:57:24.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.817750 13838 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:24.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:24.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/wal
15:57:24.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/data
15:57:24.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:24.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:24.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:24.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/logs
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/data/info.pb
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.188:37133
15:57:24.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.188
15:57:24.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:24.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:24.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44143/jwks.json with env {}
15:57:24.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.831207 13988 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.838842 13988 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.839785 13937 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.131.188:37133: connect: Connection refused (error 111)
15:57:24.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.840930 13988 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.13.131.188:37133: Network error: Client connection negotiation failed: client connection to 127.13.131.188:37133: connect: Connection refused (error 111)
15:57:24.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.850910 13916 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } attempt: 3
15:57:24.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.856382 13916 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.857829 13916 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.13.131.188:37133: Network error: Client connection negotiation failed: client connection to 127.13.131.188:37133: connect: Connection refused (error 111)
15:57:24.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.889050 13916 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } attempt: 1
15:57:24.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.890277 13988 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } attempt: 1
15:57:24.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.891031 13916 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.13.131.188:37133: Network error: Client connection negotiation failed: client connection to 127.13.131.188:37133: connect: Connection refused (error 111)
15:57:24.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.899849 13988 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.13.131.188:37133: Network error: Client connection negotiation failed: client connection to 127.13.131.188:37133: connect: Connection refused (error 111)
15:57:24.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.950484 13990 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:24.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.950881 13990 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:24.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.950937 13990 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:24.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.955327 13990 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
15:57:24.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.955400 13990 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:24.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.955420 13990 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
15:57:24.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.955436 13990 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
15:57:24.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.955453 13990 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
15:57:24.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.955466 13990 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:44143/jwks.json
15:57:24.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.961056 13990 master_runner.cc:386] Master server non-default flags:
15:57:24.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:24.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/data
15:57:24.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/wal
15:57:24.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.188:37133
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44143/jwks.json
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/data/info.pb
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.188
15:57:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13990
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/logs
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 15:02:02 UTC on ccycloud.quasar-faqpgf.root.comops.site
15:57:24.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:24.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.962167 13990 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:57:24.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.964242 13990 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:24.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.966265 13916 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } attempt: 2
15:57:24.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.967808 13916 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.13.131.188:37133: Network error: Client connection negotiation failed: client connection to 127.13.131.188:37133: connect: Connection refused (error 111)
15:57:24.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.968084 13988 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } attempt: 2
15:57:24.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.969225 13988 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.13.131.188:37133: Network error: Client connection negotiation failed: client connection to 127.13.131.188:37133: connect: Connection refused (error 111)
15:57:24.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.974745 13998 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
15:57:24.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.974964 14001 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
15:57:24.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.974745 13999 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
15:57:24.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.975126 13990 server_base.cc:1034] running on GCE node
15:57:24.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.976893 13990 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:24.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.978551 13990 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:24.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.979748 13990 hybrid_clock.cc:648] HybridClock initialized: now 1783526244979687 us; error 92 us; skew 500 ppm
15:57:24.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.982133 13990 webserver.cc:460] Webserver started at http://127.13.131.188:34949/ using document root <none> and password file <none>
15:57:24.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.982817 13990 fs_manager.cc:359] Metadata directory not provided
15:57:24.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.982905 13990 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:24.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.983165 13990 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.985570 13990 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/data/instance:
15:57:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "18dd4ffb8b16430e843581ea05e4446f"
15:57:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-h1mp"
15:57:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.986168 13990 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/wal/instance:
15:57:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "18dd4ffb8b16430e843581ea05e4446f"
15:57:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-h1mp"
15:57:24.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.990343 13990 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.007s	sys 0.000s
15:57:24.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.993453 14007 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.995088 13990 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.995242 13990 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/data,/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/wal
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "18dd4ffb8b16430e843581ea05e4446f"
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-h1mp"
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.995376 13990 fs_report.cc:383] FS layout report
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/wal
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/wal
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/data/data
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:24.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:24.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:24.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:24.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:24.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:24.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:24.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:24.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:24.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:25.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.037184 13990 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:25.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.038049 13990 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
15:57:25.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.038267 13990 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:25.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.046213 13990 rpc_server.cc:307] RPC server started. Bound to: 127.13.131.188:37133
15:57:25.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.046236 14059 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.13.131.188:37133 every 8 connection(s)
15:57:25.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.047362 13990 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/data/info.pb
15:57:25.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.050585 14060 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
15:57:25.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.053988 14060 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } has no permanent_uuid. Determining permanent_uuid...
15:57:25.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.056411 13838 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu as pid 13990
15:57:25.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.056515 13838 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/master-2/wal/instance
15:57:25.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.060397 13988 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } attempt: 3
15:57:25.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.066124 14060 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } has no permanent_uuid. Determining permanent_uuid...
15:57:25.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.067504 13916 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } attempt: 3
15:57:25.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.071399 13988 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee: Bootstrap starting.
15:57:25.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.075771 13988 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee: Neither blocks nor log segments found. Creating new log.
15:57:25.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.076917 13916 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3: Bootstrap starting.
15:57:25.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.077778 13988 log.cc:824] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee: Log is configured to *not* fsync() on all Append() calls
15:57:25.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.079373 14060 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } has no permanent_uuid. Determining permanent_uuid...
15:57:25.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.079917 13988 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee: No bootstrap required, opened a new log
15:57:25.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.081153 13916 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3: Neither blocks nor log segments found. Creating new log.
15:57:25.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.082507 13916 log.cc:824] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3: Log is configured to *not* fsync() on all Append() calls
15:57:25.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.085112 13916 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3: No bootstrap required, opened a new log
15:57:25.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.085258 13988 raft_consensus.cc:348] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } }
15:57:25.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.085484 13988 raft_consensus.cc:374] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:25.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.085532 13988 raft_consensus.cc:729] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 8228dfebede64ba28952e5a0d96ba6ee, State: Initialized, Role: FOLLOWER
15:57:25.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.086063 13988 consensus_queue.cc:260] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [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: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } }
15:57:25.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.086858 14060 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f: Bootstrap starting.
15:57:25.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.087479 13988 sys_catalog.cc:564] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [sys.catalog]: configured and running, proceeding with master startup.
15:57:25.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.089483 13916 raft_consensus.cc:348] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } }
15:57:25.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.089738 13916 raft_consensus.cc:374] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:25.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.089818 13916 raft_consensus.cc:729] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3d445944fe9442758ba226baf53a2bb3, State: Initialized, Role: FOLLOWER
15:57:25.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.090703 14060 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f: Neither blocks nor log segments found. Creating new log.
15:57:25.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.090626 13916 consensus_queue.cc:260] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [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: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } }
15:57:25.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.091080 14083 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [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: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } } }
15:57:25.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.091197 14083 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [sys.catalog]: This master's current role is: FOLLOWER
15:57:25.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.091991 13916 sys_catalog.cc:564] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [sys.catalog]: configured and running, proceeding with master startup.
15:57:25.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.093528 14060 log.cc:824] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f: Log is configured to *not* fsync() on all Append() calls
15:57:25.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.091598 13918 master_runner.cc:186] Error getting master registration for 127.13.131.190:44151: OK, instance_id { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" instance_seqno: 1783526244613246 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
15:57:25.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.094980 13918 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
15:57:25.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.100020 14082 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
15:57:25.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.100106 14082 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
15:57:25.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.100661 14071 sys_catalog.cc:455] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [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: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } } }
15:57:25.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.100785 14071 sys_catalog.cc:458] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [sys.catalog]: This master's current role is: FOLLOWER
15:57:25.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.103859 14095 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
15:57:25.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.103943 14095 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
15:57:25.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.105822 14060 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f: No bootstrap required, opened a new log
15:57:25.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.102727 13849 master_runner.cc:186] Error getting master registration for 127.13.131.188:37133: OK, instance_id { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" instance_seqno: 1783526245044056 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
15:57:25.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.106078 13849 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
15:57:25.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.109859 13869 tablet.cc:2369] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3: Can't schedule compaction. Clean time has not been advanced past its initial value.
15:57:25.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.110366 14060 raft_consensus.cc:348] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } }
15:57:25.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.110625 14060 raft_consensus.cc:374] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:25.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.110705 14060 raft_consensus.cc:729] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 18dd4ffb8b16430e843581ea05e4446f, State: Initialized, Role: FOLLOWER
15:57:25.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.111209 14060 consensus_queue.cc:260] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [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: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } }
15:57:25.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.112664 14060 sys_catalog.cc:564] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [sys.catalog]: configured and running, proceeding with master startup.
15:57:25.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.113899 14098 sys_catalog.cc:455] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [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: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } } }
15:57:25.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.114835 14098 sys_catalog.cc:458] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [sys.catalog]: This master's current role is: FOLLOWER
15:57:25.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.118294 14109 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
15:57:25.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.118566 14109 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
15:57:25.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.121385 13990 master_runner.cc:263] No leader master found from master 18dd4ffb8b16430e843581ea05e4446f
15:57:25.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.121457 13990 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
15:57:25.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.159960 14098 raft_consensus.cc:482] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
15:57:25.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.160168 14098 raft_consensus.cc:504] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } }
15:57:25.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.161268 14098 leader_election.cc:288] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 3d445944fe9442758ba226baf53a2bb3 (127.13.131.190:44151), 8228dfebede64ba28952e5a0d96ba6ee (127.13.131.189:41587)
15:57:25.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.162943 13962 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "18dd4ffb8b16430e843581ea05e4446f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "8228dfebede64ba28952e5a0d96ba6ee" is_pre_election: true
15:57:25.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.163271 13962 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 18dd4ffb8b16430e843581ea05e4446f in term 0.
15:57:25.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.163712 14009 leader_election.cc:302] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [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: 18dd4ffb8b16430e843581ea05e4446f, 8228dfebede64ba28952e5a0d96ba6ee; no voters: 
15:57:25.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.165393 13890 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "18dd4ffb8b16430e843581ea05e4446f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3d445944fe9442758ba226baf53a2bb3" is_pre_election: true
15:57:25.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.165717 13890 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 18dd4ffb8b16430e843581ea05e4446f in term 0.
15:57:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.166759 14098 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [term 0 FOLLOWER]: Leader pre-election won for term 1
15:57:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.166865 14098 raft_consensus.cc:482] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
15:57:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.166909 14098 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [term 0 FOLLOWER]: Advancing to term 1
15:57:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.168161 14098 raft_consensus.cc:504] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } }
15:57:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.168536 14098 leader_election.cc:288] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [CANDIDATE]: Term 1 election: Requested vote from peers 3d445944fe9442758ba226baf53a2bb3 (127.13.131.190:44151), 8228dfebede64ba28952e5a0d96ba6ee (127.13.131.189:41587)
15:57:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.169013 13962 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "18dd4ffb8b16430e843581ea05e4446f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "8228dfebede64ba28952e5a0d96ba6ee"
15:57:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.169138 13962 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [term 0 FOLLOWER]: Advancing to term 1
15:57:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.170341 13962 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 18dd4ffb8b16430e843581ea05e4446f in term 1.
15:57:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.170673 14009 leader_election.cc:302] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 18dd4ffb8b16430e843581ea05e4446f, 8228dfebede64ba28952e5a0d96ba6ee; no voters: 
15:57:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.171198 13890 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "18dd4ffb8b16430e843581ea05e4446f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3d445944fe9442758ba226baf53a2bb3"
15:57:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.171324 13890 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [term 0 FOLLOWER]: Advancing to term 1
15:57:25.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.172492 13890 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 18dd4ffb8b16430e843581ea05e4446f in term 1.
15:57:25.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.175846 14098 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [term 1 FOLLOWER]: Leader election won for term 1
15:57:25.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.176112 14098 raft_consensus.cc:686] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [term 1 LEADER]: Becoming Leader. State: Replica: 18dd4ffb8b16430e843581ea05e4446f, State: Running, Role: LEADER
15:57:25.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.176533 14098 consensus_queue.cc:237] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [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: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } }
15:57:25.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.183418 14098 sys_catalog.cc:455] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [sys.catalog]: SysCatalogTable state changed. Reason: New leader 18dd4ffb8b16430e843581ea05e4446f. Latest consensus state: current_term: 1 leader_uuid: "18dd4ffb8b16430e843581ea05e4446f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } } }
15:57:25.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.183575 14098 sys_catalog.cc:458] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [sys.catalog]: This master's current role is: LEADER
15:57:25.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.187836 14113 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
15:57:25.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.192134 14113 catalog_manager.cc:1484] Initializing Kudu cluster ID...
15:57:25.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.203328 13962 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [term 1 FOLLOWER]: Refusing update from remote peer 18dd4ffb8b16430e843581ea05e4446f: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
15:57:25.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.205561 14111 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [LEADER]: Connected to new peer: Peer: permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
15:57:25.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.210662 14071 sys_catalog.cc:455] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [sys.catalog]: SysCatalogTable state changed. Reason: New leader 18dd4ffb8b16430e843581ea05e4446f. Latest consensus state: current_term: 1 leader_uuid: "18dd4ffb8b16430e843581ea05e4446f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } } }
15:57:25.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.210834 14071 sys_catalog.cc:458] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [sys.catalog]: This master's current role is: FOLLOWER
15:57:25.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.215236 13890 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [term 1 FOLLOWER]: Refusing update from remote peer 18dd4ffb8b16430e843581ea05e4446f: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
15:57:25.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.216238 14111 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [LEADER]: Connected to new peer: Peer: permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
15:57:25.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.220504 14083 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 18dd4ffb8b16430e843581ea05e4446f. Latest consensus state: current_term: 1 leader_uuid: "18dd4ffb8b16430e843581ea05e4446f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } } }
15:57:25.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.220626 14083 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [sys.catalog]: This master's current role is: FOLLOWER
15:57:25.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.231282 14111 sys_catalog.cc:455] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "18dd4ffb8b16430e843581ea05e4446f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } } }
15:57:25.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.231581 14111 sys_catalog.cc:458] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [sys.catalog]: This master's current role is: LEADER
15:57:25.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.233944 14083 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "18dd4ffb8b16430e843581ea05e4446f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } } }
15:57:25.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.234105 14083 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3 [sys.catalog]: This master's current role is: FOLLOWER
15:57:25.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.234961 14114 mvcc.cc:205] Tried to move back new op lower bound from 7305323500344369152 to 7305323500261597184. Current Snapshot: MvccSnapshot[applied={T|T < 7305323500344369152}]
15:57:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.237535 14098 sys_catalog.cc:455] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "18dd4ffb8b16430e843581ea05e4446f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } } }
15:57:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.237677 14098 sys_catalog.cc:458] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f [sys.catalog]: This master's current role is: LEADER
15:57:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.238909 14071 sys_catalog.cc:455] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "18dd4ffb8b16430e843581ea05e4446f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d445944fe9442758ba226baf53a2bb3" member_type: VOTER last_known_addr { host: "127.13.131.190" port: 44151 } } peers { permanent_uuid: "8228dfebede64ba28952e5a0d96ba6ee" member_type: VOTER last_known_addr { host: "127.13.131.189" port: 41587 } } peers { permanent_uuid: "18dd4ffb8b16430e843581ea05e4446f" member_type: VOTER last_known_addr { host: "127.13.131.188" port: 37133 } } }
15:57:25.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.239078 14071 sys_catalog.cc:458] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee [sys.catalog]: This master's current role is: FOLLOWER
15:57:25.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.241190 14117 mvcc.cc:205] Tried to move back new op lower bound from 7305323500344369152 to 7305323500261597184. Current Snapshot: MvccSnapshot[applied={T|T < 7305323500344369152}]
15:57:25.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.241876 14115 mvcc.cc:205] Tried to move back new op lower bound from 7305323500344369152 to 7305323500261597184. Current Snapshot: MvccSnapshot[applied={T|T < 7305323500344369152}]
15:57:25.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.246888 14113 catalog_manager.cc:1347] Generated new cluster ID: f3cb876cb5524a518bf3ce6dfed12103
15:57:25.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.246979 14113 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
15:57:25.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.268188 14113 catalog_manager.cc:1370] Generated new certificate authority record
15:57:25.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.269829 14113 catalog_manager.cc:1504] Loading token signing keys...
15:57:25.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.292338 14113 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 18dd4ffb8b16430e843581ea05e4446f: Generated new TSK 0
15:57:25.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.293501 14113 catalog_manager.cc:1514] Initializing in-progress tserver states...
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.308881 13838 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/wal
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/data
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/logs
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/data/info.pb
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.129:0
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.131.129
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.129
15:57:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:25.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:25.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
15:57:25.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.435366 14124 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:25.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.435654 14124 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:25.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.435691 14124 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:25.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.439765 14124 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.439862 14124 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.131.129
15:57:25.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.444653 14124 tablet_server_runner.cc:78] Tablet server non-default flags:
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/data
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/wal
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.129:0
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/data/info.pb
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.129
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.14124
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.131.129
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/logs
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:25.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:25.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:57:25.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:25.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:25.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:25.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 15:02:02 UTC on ccycloud.quasar-faqpgf.root.comops.site
15:57:25.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:25.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.445752 14124 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:57:25.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.447150 14124 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:25.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.456954 14129 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
15:57:25.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.456995 14130 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
15:57:25.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.457010 14132 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
15:57:25.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.457114 14124 server_base.cc:1034] running on GCE node
15:57:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.458081 14124 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.458882 14124 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:25.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.460070 14124 hybrid_clock.cc:648] HybridClock initialized: now 1783526245460034 us; error 50 us; skew 500 ppm
15:57:25.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.465906 14124 webserver.cc:460] Webserver started at http://127.13.131.129:41127/ using document root <none> and password file <none>
15:57:25.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.466619 14124 fs_manager.cc:359] Metadata directory not provided
15:57:25.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.466751 14124 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:25.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.467036 14124 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:25.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.469403 14124 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/data/instance:
15:57:25.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a"
15:57:25.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-h1mp"
15:57:25.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.470052 14124 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/wal/instance:
15:57:25.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a"
15:57:25.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-h1mp"
15:57:25.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.474649 14124 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.006s	sys 0.000s
15:57:25.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.479153 14138 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.481038 14124 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.000s
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.481186 14124 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/data,/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/wal
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a"
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-h1mp"
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.481350 14124 fs_report.cc:383] FS layout report
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/wal
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/wal
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/data/data
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:25.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:25.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:25.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:25.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:25.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:25.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:25.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:25.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:25.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:25.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.507984 14124 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:25.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.509120 14124 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
15:57:25.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.509407 14124 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:25.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.510330 14124 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:57:25.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.511932 14124 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:57:25.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.511983 14124 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:57:25.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.512028 14124 ts_tablet_manager.cc:610] Registered 0 tablets
15:57:25.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.512074 14124 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:57:25.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.524400 14124 rpc_server.cc:307] RPC server started. Bound to: 127.13.131.129:43321
15:57:25.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.524446 14251 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.13.131.129:43321 every 8 connection(s)
15:57:25.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.525838 14124 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/data/info.pb
15:57:25.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.528359 13838 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu as pid 14124
15:57:25.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.528471 13838 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-0/wal/instance
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.532714 13838 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/wal
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/data
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/logs
15:57:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/data/info.pb
15:57:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:57:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.130:0
15:57:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.131.130
15:57:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.130
15:57:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
15:57:25.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.538733 14253 heartbeater.cc:347] Connected to a master server at 127.13.131.190:44151
15:57:25.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.538996 14253 heartbeater.cc:464] Registering TS with master...
15:57:25.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.539626 14252 heartbeater.cc:347] Connected to a master server at 127.13.131.188:37133
15:57:25.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.539647 14253 heartbeater.cc:511] Master 127.13.131.190:44151 requested a full tablet report, sending...
15:57:25.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.539737 14252 heartbeater.cc:464] Registering TS with master...
15:57:25.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.539937 14252 heartbeater.cc:511] Master 127.13.131.188:37133 requested a full tablet report, sending...
15:57:25.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.541267 14024 ts_manager.cc:194] Registered new tserver with Master: e0bbb2dcb0ad4709a432dc47f88a3e0a (127.13.131.129:43321)
15:57:25.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.543033 14024 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.13.131.129:40725
15:57:25.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.543453 13880 ts_manager.cc:194] Registered new tserver with Master: e0bbb2dcb0ad4709a432dc47f88a3e0a (127.13.131.129:43321)
15:57:25.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.544706 14254 heartbeater.cc:347] Connected to a master server at 127.13.131.189:41587
15:57:25.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.544806 14254 heartbeater.cc:464] Registering TS with master...
15:57:25.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.544981 14254 heartbeater.cc:511] Master 127.13.131.189:41587 requested a full tablet report, sending...
15:57:25.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.546259 13945 ts_manager.cc:194] Registered new tserver with Master: e0bbb2dcb0ad4709a432dc47f88a3e0a (127.13.131.129:43321)
15:57:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.654206 14259 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.654466 14259 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.654521 14259 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:25.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.658663 14259 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:25.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.658785 14259 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.131.130
15:57:25.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.663580 14259 tablet_server_runner.cc:78] Tablet server non-default flags:
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/data
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/wal
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.130:0
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/data/info.pb
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.130
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.14259
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.131.130
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/logs
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:25.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 15:02:02 UTC on ccycloud.quasar-faqpgf.root.comops.site
15:57:25.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:25.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.664708 14259 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:57:25.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.666065 14259 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:25.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.676061 14265 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
15:57:25.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.676090 14267 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
15:57:25.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.676111 14259 server_base.cc:1034] running on GCE node
15:57:25.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.676240 14264 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
15:57:25.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.677138 14259 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:25.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.677985 14259 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:25.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.679162 14259 hybrid_clock.cc:648] HybridClock initialized: now 1783526245679127 us; error 53 us; skew 500 ppm
15:57:25.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.681341 14259 webserver.cc:460] Webserver started at http://127.13.131.130:38369/ using document root <none> and password file <none>
15:57:25.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.681962 14259 fs_manager.cc:359] Metadata directory not provided
15:57:25.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.682057 14259 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:25.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.682299 14259 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.684329 14259 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/data/instance:
15:57:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ece09985778043cfb1b288b9fb40ba64"
15:57:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-h1mp"
15:57:25.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.684931 14259 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/wal/instance:
15:57:25.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ece09985778043cfb1b288b9fb40ba64"
15:57:25.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-h1mp"
15:57:25.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.689065 14259 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
15:57:25.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.691766 14273 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.693077 14259 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.693214 14259 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/data,/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/wal
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ece09985778043cfb1b288b9fb40ba64"
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-h1mp"
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.693323 14259 fs_report.cc:383] FS layout report
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/wal
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/wal
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/data/data
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:25.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:25.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:25.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:25.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:25.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:25.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:25.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:25.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.718150 14259 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:25.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.719031 14259 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
15:57:25.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.719287 14259 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:25.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.719971 14259 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.720993 14259 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.721066 14259 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.721123 14259 ts_tablet_manager.cc:610] Registered 0 tablets
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.721148 14259 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:57:25.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.730206 14259 rpc_server.cc:307] RPC server started. Bound to: 127.13.131.130:41683
15:57:25.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.730242 14386 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.13.131.130:41683 every 8 connection(s)
15:57:25.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.731207 14259 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/data/info.pb
15:57:25.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.741744 13838 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu as pid 14259
15:57:25.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.741858 13838 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-1/wal/instance
15:57:25.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.744045 14389 heartbeater.cc:347] Connected to a master server at 127.13.131.189:41587
15:57:25.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.744136 14388 heartbeater.cc:347] Connected to a master server at 127.13.131.190:44151
15:57:25.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.744475 14387 heartbeater.cc:347] Connected to a master server at 127.13.131.188:37133
15:57:25.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.744567 14387 heartbeater.cc:464] Registering TS with master...
15:57:25.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.744530 14388 heartbeater.cc:464] Registering TS with master...
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.744530 14389 heartbeater.cc:464] Registering TS with master...
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.745241 14388 heartbeater.cc:511] Master 127.13.131.190:44151 requested a full tablet report, sending...
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.745244 14387 heartbeater.cc:511] Master 127.13.131.188:37133 requested a full tablet report, sending...
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.745391 13838 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/wal
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/data
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/logs
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/data/info.pb
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.131:0
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.131.131
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.131
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.745287 14389 heartbeater.cc:511] Master 127.13.131.189:41587 requested a full tablet report, sending...
15:57:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.746415 14024 ts_manager.cc:194] Registered new tserver with Master: ece09985778043cfb1b288b9fb40ba64 (127.13.131.130:41683)
15:57:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.747118 13880 ts_manager.cc:194] Registered new tserver with Master: ece09985778043cfb1b288b9fb40ba64 (127.13.131.130:41683)
15:57:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.747231 14024 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.13.131.130:46271
15:57:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.747247 13945 ts_manager.cc:194] Registered new tserver with Master: ece09985778043cfb1b288b9fb40ba64 (127.13.131.130:41683)
15:57:25.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.859529 14394 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:25.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.859807 14394 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:25.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.859843 14394 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:25.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.863848 14394 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:25.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.863940 14394 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.131.131
15:57:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.868592 14394 tablet_server_runner.cc:78] Tablet server non-default flags:
15:57:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.131.148:35721
15:57:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/data
15:57:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/wal
15:57:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.131.131:0
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/data/info.pb
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.131.131
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.131.190:44151,127.13.131.189:41587,127.13.131.188:37133
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.14394
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.131.131
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/logs
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 15:02:02 UTC on ccycloud.quasar-faqpgf.root.comops.site
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:25.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.869727 14394 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:57:25.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.871079 14394 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.881961 14402 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
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.882009 14400 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
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.882009 14399 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
15:57:25.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.882925 14394 server_base.cc:1034] running on GCE node
15:57:25.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.883334 14394 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:25.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.884001 14394 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:25.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.885251 14394 hybrid_clock.cc:648] HybridClock initialized: now 1783526245885213 us; error 48 us; skew 500 ppm
15:57:25.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.887550 14394 webserver.cc:460] Webserver started at http://127.13.131.131:41197/ using document root <none> and password file <none>
15:57:25.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.888211 14394 fs_manager.cc:359] Metadata directory not provided
15:57:25.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.888300 14394 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:25.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.888566 14394 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:25.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.890532 14394 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/data/instance:
15:57:25.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8"
15:57:25.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-h1mp"
15:57:25.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.891160 14394 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/wal/instance:
15:57:25.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8"
15:57:25.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-h1mp"
15:57:25.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.895033 14394 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
15:57:25.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.897562 14408 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:57:25.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.898877 14394 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.899015 14394 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/data,/tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/wal
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8"
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-h1mp"
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.899135 14394 fs_report.cc:383] FS layout report
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/wal
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/wal
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/data/data
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:25.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.923285 14394 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:25.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.923981 14394 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
15:57:25.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.924135 14394 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:25.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.924743 14394 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:57:25.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.925782 14394 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:57:25.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.925855 14394 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:57:25.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.925922 14394 ts_tablet_manager.cc:610] Registered 0 tablets
15:57:25.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.925945 14394 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:57:25.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.934964 14394 rpc_server.cc:307] RPC server started. Bound to: 127.13.131.131:33177
15:57:25.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.935015 14521 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.13.131.131:33177 every 8 connection(s)
15:57:25.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.935909 14394 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/data/info.pb
15:57:25.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.942018 13838 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu as pid 14394
15:57:25.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.942133 13838 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskzQ3kQc/test-tmp/mini-kudu-cluster4958607839061148930/ts-2/wal/instance
15:57:25.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.949468 14522 heartbeater.cc:347] Connected to a master server at 127.13.131.188:37133
15:57:25.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.949560 14524 heartbeater.cc:347] Connected to a master server at 127.13.131.189:41587
15:57:25.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.949591 14523 heartbeater.cc:347] Connected to a master server at 127.13.131.190:44151
15:57:25.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.949713 14523 heartbeater.cc:464] Registering TS with master...
15:57:25.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.949713 14524 heartbeater.cc:464] Registering TS with master...
15:57:25.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.949712 14522 heartbeater.cc:464] Registering TS with master...
15:57:25.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.950366 14524 heartbeater.cc:511] Master 127.13.131.189:41587 requested a full tablet report, sending...
15:57:25.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.950366 14523 heartbeater.cc:511] Master 127.13.131.190:44151 requested a full tablet report, sending...
15:57:25.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.950364 14522 heartbeater.cc:511] Master 127.13.131.188:37133 requested a full tablet report, sending...
15:57:25.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.951508 14024 ts_manager.cc:194] Registered new tserver with Master: 5d1bbfc5c8d84c69a2364d1332ad00b8 (127.13.131.131:33177)
15:57:25.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.951632 13945 ts_manager.cc:194] Registered new tserver with Master: 5d1bbfc5c8d84c69a2364d1332ad00b8 (127.13.131.131:33177)
15:57:25.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.951702 13880 ts_manager.cc:194] Registered new tserver with Master: 5d1bbfc5c8d84c69a2364d1332ad00b8 (127.13.131.131:33177)
15:57:25.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.952224 14024 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.13.131.131:45955
15:57:25.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.963452 13838 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
15:57:25.964 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
15:57:25.965 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

15:57:25.978 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.131.190"
      port: 44151
    }
    bound_http_address {
      host: "127.13.131.190"
      port: 37697
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.13.131.189"
      port: 41587
    }
    bound_http_address {
      host: "127.13.131.189"
      port: 33911
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.13.131.188"
      port: 37133
    }
    bound_http_address {
      host: "127.13.131.188"
      port: 34949
    }
  }
}

15:57:25.983 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

15:57:25.987 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.131.129"
      port: 43321
    }
    bound_http_address {
      host: "127.13.131.129"
      port: 41127
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.13.131.130"
      port: 41683
    }
    bound_http_address {
      host: "127.13.131.130"
      port: 38369
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.13.131.131"
      port: 33177
    }
    bound_http_address {
      host: "127.13.131.131"
      port: 41197
    }
  }
}

15:57:25.987 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
15:57:26.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.101728 14082 catalog_manager.cc:1259] Loaded cluster ID: f3cb876cb5524a518bf3ce6dfed12103
15:57:26.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.101816 14082 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee: loading cluster ID for follower catalog manager: success
15:57:26.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.104254 14082 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee: acquiring CA information for follower catalog manager: success
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.105142 14095 catalog_manager.cc:1259] Loaded cluster ID: f3cb876cb5524a518bf3ce6dfed12103
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.105207 14095 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3: loading cluster ID for follower catalog manager: success
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.105675 14082 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 8228dfebede64ba28952e5a0d96ba6ee: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
15:57:26.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.107043 14095 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3: acquiring CA information for follower catalog manager: success
15:57:26.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.108287 14095 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 3d445944fe9442758ba226baf53a2bb3: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
15:57:26.179 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
15:57:26.358 [DEBUG - main] (Connection.java:748) [peer master-127.13.131.189:41587(127.13.131.189:41587)] connecting to peer
15:57:26.411 [DEBUG - main] (Connection.java:748) [peer master-127.13.131.190:44151(127.13.131.190:44151)] connecting to peer
15:57:26.412 [DEBUG - main] (Connection.java:748) [peer master-127.13.131.188:37133(127.13.131.188:37133)] connecting to peer
15:57:26.433 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.13.131.189:41587(127.13.131.189:41587)] Successfully connected to peer
15:57:26.433 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.13.131.190:44151(127.13.131.190:44151)] Successfully connected to peer
15:57:26.497 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.13.131.188:37133(127.13.131.188:37133)] Successfully connected to peer
15:57:26.519 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.131.190
15:57:26.519 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.131.189
15:57:26.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.545955 14252 heartbeater.cc:503] Master 127.13.131.188:37133 was elected leader, sending a full tablet report...
15:57:26.618 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.131.188
15:57:26.732 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xb4293870, L:/127.0.0.1:47904 - R:/127.13.131.189:41587] using SASL/PLAIN
15:57:26.732 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xf6bfd0f3, L:/127.0.0.1:57366 - R:/127.13.131.190:44151] using SASL/PLAIN
15:57:26.747 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xb343565a, L:/127.0.0.1:48316 - R:/127.13.131.188:37133] using SASL/PLAIN
15:57:26.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.749214 14387 heartbeater.cc:503] Master 127.13.131.188:37133 was elected leader, sending a full tablet report...
15:57:26.779 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
15:57:26.781 [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, [34ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.131.189:41587, [94ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.131.190:44151, [95ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.131.188:37133, [428ms] Sub RPC ConnectToMaster: received response from server master-127.13.131.189:41587: OK, [428ms] Sub RPC ConnectToMaster: received response from server master-127.13.131.190:44151: OK, [436ms] Sub RPC ConnectToMaster: received response from server master-127.13.131.188:37133: OK, deferred=null) after lookup
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.832724 14023 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:48316:
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783526243995"
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
15:57:26.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
15:57:26.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
15:57:26.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
15:57:26.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
15:57:26.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:26.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
15:57:26.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.836153 14023 catalog_manager.cc:6854] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1783526243995 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
15:57:26.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.861056 14456 tablet_service.cc:1467] Processing CreateTablet for tablet a4dbac32b95f43069590704182f065d6 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783526243995 [id=59541ef0be8a478393268551c9169b44]), partition=RANGE (key) PARTITION UNBOUNDED
15:57:26.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.862258 14456 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet a4dbac32b95f43069590704182f065d6. 1 dirs total, 0 dirs full, 0 dirs failed
15:57:26.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.863543 14186 tablet_service.cc:1467] Processing CreateTablet for tablet a4dbac32b95f43069590704182f065d6 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783526243995 [id=59541ef0be8a478393268551c9169b44]), partition=RANGE (key) PARTITION UNBOUNDED
15:57:26.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.864598 14186 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet a4dbac32b95f43069590704182f065d6. 1 dirs total, 0 dirs full, 0 dirs failed
15:57:26.871 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 59541ef0be8a478393268551c9169b44
15:57:26.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.870826 14321 tablet_service.cc:1467] Processing CreateTablet for tablet a4dbac32b95f43069590704182f065d6 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783526243995 [id=59541ef0be8a478393268551c9169b44]), partition=RANGE (key) PARTITION UNBOUNDED
15:57:26.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.871884 14321 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet a4dbac32b95f43069590704182f065d6. 1 dirs total, 0 dirs full, 0 dirs failed
15:57:26.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.872931 14549 tablet_bootstrap.cc:492] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a: Bootstrap starting.
15:57:26.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.875182 14550 tablet_bootstrap.cc:492] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8: Bootstrap starting.
15:57:26.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.875576 14549 tablet_bootstrap.cc:654] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a: Neither blocks nor log segments found. Creating new log.
15:57:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.877542 14550 tablet_bootstrap.cc:654] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8: Neither blocks nor log segments found. Creating new log.
15:57:26.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.878527 14550 log.cc:824] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8: Log is configured to *not* fsync() on all Append() calls
15:57:26.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.879405 14549 log.cc:824] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a: Log is configured to *not* fsync() on all Append() calls
15:57:26.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.881001 14552 tablet_bootstrap.cc:492] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64: Bootstrap starting.
15:57:26.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.881507 14550 tablet_bootstrap.cc:492] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8: No bootstrap required, opened a new log
15:57:26.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.881592 14549 tablet_bootstrap.cc:492] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a: No bootstrap required, opened a new log
15:57:26.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.881716 14550 ts_tablet_manager.cc:1397] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8: Time spent bootstrapping tablet: real 0.007s	user 0.004s	sys 0.000s
15:57:26.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.881768 14549 ts_tablet_manager.cc:1397] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a: Time spent bootstrapping tablet: real 0.009s	user 0.004s	sys 0.000s
15:57:26.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.884852 14552 tablet_bootstrap.cc:654] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64: Neither blocks nor log segments found. Creating new log.
15:57:26.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.885826 14552 log.cc:824] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64: Log is configured to *not* fsync() on all Append() calls
15:57:26.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.886224 14549 raft_consensus.cc:348] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ece09985778043cfb1b288b9fb40ba64" member_type: VOTER last_known_addr { host: "127.13.131.130" port: 41683 } } peers { permanent_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" member_type: VOTER last_known_addr { host: "127.13.131.131" port: 33177 } } peers { permanent_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" member_type: VOTER last_known_addr { host: "127.13.131.129" port: 43321 } }
15:57:26.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.886782 14549 raft_consensus.cc:374] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:26.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.886854 14549 raft_consensus.cc:729] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e0bbb2dcb0ad4709a432dc47f88a3e0a, State: Initialized, Role: FOLLOWER
15:57:26.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.886920 14550 raft_consensus.cc:348] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ece09985778043cfb1b288b9fb40ba64" member_type: VOTER last_known_addr { host: "127.13.131.130" port: 41683 } } peers { permanent_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" member_type: VOTER last_known_addr { host: "127.13.131.131" port: 33177 } } peers { permanent_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" member_type: VOTER last_known_addr { host: "127.13.131.129" port: 43321 } }
15:57:26.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.887244 14550 raft_consensus.cc:374] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:26.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.887305 14550 raft_consensus.cc:729] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 5d1bbfc5c8d84c69a2364d1332ad00b8, State: Initialized, Role: FOLLOWER
15:57:26.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.887848 14550 consensus_queue.cc:260] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [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: "ece09985778043cfb1b288b9fb40ba64" member_type: VOTER last_known_addr { host: "127.13.131.130" port: 41683 } } peers { permanent_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" member_type: VOTER last_known_addr { host: "127.13.131.131" port: 33177 } } peers { permanent_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" member_type: VOTER last_known_addr { host: "127.13.131.129" port: 43321 } }
15:57:26.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.888583 14552 tablet_bootstrap.cc:492] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64: No bootstrap required, opened a new log
15:57:26.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.888784 14522 heartbeater.cc:503] Master 127.13.131.188:37133 was elected leader, sending a full tablet report...
15:57:26.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.888947 14552 ts_tablet_manager.cc:1397] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64: Time spent bootstrapping tablet: real 0.008s	user 0.006s	sys 0.000s
15:57:26.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.888538 14549 consensus_queue.cc:260] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a [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: "ece09985778043cfb1b288b9fb40ba64" member_type: VOTER last_known_addr { host: "127.13.131.130" port: 41683 } } peers { permanent_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" member_type: VOTER last_known_addr { host: "127.13.131.131" port: 33177 } } peers { permanent_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" member_type: VOTER last_known_addr { host: "127.13.131.129" port: 43321 } }
15:57:26.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.891127 14549 ts_tablet_manager.cc:1428] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a: Time spent starting tablet: real 0.009s	user 0.004s	sys 0.004s
15:57:26.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.892025 14550 ts_tablet_manager.cc:1428] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8: Time spent starting tablet: real 0.010s	user 0.008s	sys 0.000s
15:57:26.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.894013 14552 raft_consensus.cc:348] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ece09985778043cfb1b288b9fb40ba64" member_type: VOTER last_known_addr { host: "127.13.131.130" port: 41683 } } peers { permanent_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" member_type: VOTER last_known_addr { host: "127.13.131.131" port: 33177 } } peers { permanent_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" member_type: VOTER last_known_addr { host: "127.13.131.129" port: 43321 } }
15:57:26.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.897671 14552 raft_consensus.cc:374] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:26.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.897863 14552 raft_consensus.cc:729] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ece09985778043cfb1b288b9fb40ba64, State: Initialized, Role: FOLLOWER
15:57:26.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.898461 14552 consensus_queue.cc:260] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64 [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: "ece09985778043cfb1b288b9fb40ba64" member_type: VOTER last_known_addr { host: "127.13.131.130" port: 41683 } } peers { permanent_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" member_type: VOTER last_known_addr { host: "127.13.131.131" port: 33177 } } peers { permanent_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" member_type: VOTER last_known_addr { host: "127.13.131.129" port: 43321 } }
15:57:26.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.899742 14552 ts_tablet_manager.cc:1428] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64: Time spent starting tablet: real 0.011s	user 0.002s	sys 0.004s
15:57:26.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.934006 14555 raft_consensus.cc:482] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
15:57:26.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.934320 14555 raft_consensus.cc:504] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ece09985778043cfb1b288b9fb40ba64" member_type: VOTER last_known_addr { host: "127.13.131.130" port: 41683 } } peers { permanent_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" member_type: VOTER last_known_addr { host: "127.13.131.131" port: 33177 } } peers { permanent_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" member_type: VOTER last_known_addr { host: "127.13.131.129" port: 43321 } }
15:57:26.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.935727 14555 leader_election.cc:288] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers ece09985778043cfb1b288b9fb40ba64 (127.13.131.130:41683), e0bbb2dcb0ad4709a432dc47f88a3e0a (127.13.131.129:43321)
15:57:26.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.937883 14525 tablet.cc:2369] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8: Can't schedule compaction. Clean time has not been advanced past its initial value.
15:57:26.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.941704 14341 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "a4dbac32b95f43069590704182f065d6" candidate_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ece09985778043cfb1b288b9fb40ba64" is_pre_election: true
15:57:26.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.941855 14206 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "a4dbac32b95f43069590704182f065d6" candidate_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" is_pre_election: true
15:57:26.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.942044 14341 raft_consensus.cc:2454] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 5d1bbfc5c8d84c69a2364d1332ad00b8 in term 0.
15:57:26.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.942117 14206 raft_consensus.cc:2454] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 5d1bbfc5c8d84c69a2364d1332ad00b8 in term 0.
15:57:26.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.942560 14411 leader_election.cc:302] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [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: 5d1bbfc5c8d84c69a2364d1332ad00b8, ece09985778043cfb1b288b9fb40ba64; no voters: 
15:57:26.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.942905 14555 raft_consensus.cc:2781] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [term 0 FOLLOWER]: Leader pre-election won for term 1
15:57:26.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.942991 14555 raft_consensus.cc:482] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
15:57:26.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.943029 14555 raft_consensus.cc:3037] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [term 0 FOLLOWER]: Advancing to term 1
15:57:26.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.944140 14555 raft_consensus.cc:504] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ece09985778043cfb1b288b9fb40ba64" member_type: VOTER last_known_addr { host: "127.13.131.130" port: 41683 } } peers { permanent_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" member_type: VOTER last_known_addr { host: "127.13.131.131" port: 33177 } } peers { permanent_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" member_type: VOTER last_known_addr { host: "127.13.131.129" port: 43321 } }
15:57:26.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.944525 14555 leader_election.cc:288] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [CANDIDATE]: Term 1 election: Requested vote from peers ece09985778043cfb1b288b9fb40ba64 (127.13.131.130:41683), e0bbb2dcb0ad4709a432dc47f88a3e0a (127.13.131.129:43321)
15:57:26.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.944988 14206 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "a4dbac32b95f43069590704182f065d6" candidate_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a"
15:57:26.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.944969 14341 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "a4dbac32b95f43069590704182f065d6" candidate_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ece09985778043cfb1b288b9fb40ba64"
15:57:26.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.945117 14206 raft_consensus.cc:3037] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a [term 0 FOLLOWER]: Advancing to term 1
15:57:26.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.945147 14341 raft_consensus.cc:3037] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64 [term 0 FOLLOWER]: Advancing to term 1
15:57:26.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.946229 14341 raft_consensus.cc:2454] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 5d1bbfc5c8d84c69a2364d1332ad00b8 in term 1.
15:57:26.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.946249 14206 raft_consensus.cc:2454] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 5d1bbfc5c8d84c69a2364d1332ad00b8 in term 1.
15:57:26.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.946564 14410 leader_election.cc:302] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 5d1bbfc5c8d84c69a2364d1332ad00b8, e0bbb2dcb0ad4709a432dc47f88a3e0a; no voters: 
15:57:26.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.946785 14555 raft_consensus.cc:2781] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [term 1 FOLLOWER]: Leader election won for term 1
15:57:26.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.947095 14555 raft_consensus.cc:686] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [term 1 LEADER]: Becoming Leader. State: Replica: 5d1bbfc5c8d84c69a2364d1332ad00b8, State: Running, Role: LEADER
15:57:26.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.947484 14555 consensus_queue.cc:237] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [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: "ece09985778043cfb1b288b9fb40ba64" member_type: VOTER last_known_addr { host: "127.13.131.130" port: 41683 } } peers { permanent_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" member_type: VOTER last_known_addr { host: "127.13.131.131" port: 33177 } } peers { permanent_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" member_type: VOTER last_known_addr { host: "127.13.131.129" port: 43321 } }
15:57:26.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.951215 14024 catalog_manager.cc:5495] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 reported cstate change: term changed from 0 to 1, leader changed from <none> to 5d1bbfc5c8d84c69a2364d1332ad00b8 (127.13.131.131). New cstate: current_term: 1 leader_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ece09985778043cfb1b288b9fb40ba64" member_type: VOTER last_known_addr { host: "127.13.131.130" port: 41683 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "5d1bbfc5c8d84c69a2364d1332ad00b8" member_type: VOTER last_known_addr { host: "127.13.131.131" port: 33177 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" member_type: VOTER last_known_addr { host: "127.13.131.129" port: 43321 } health_report { overall_health: UNKNOWN } } }
15:57:26.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.983352 14390 tablet.cc:2369] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64: Can't schedule compaction. Clean time has not been advanced past its initial value.
15:57:26.994 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet a4dbac32b95f43069590704182f065d6 for table 'org.apache.kudu.client.TestHybridTime-1783526243995' with partition [<start>, <end>)
15:57:27.001 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=a4dbac32b95f43069590704182f065d6@[5d1bbfc5c8d84c69a2364d1332ad00b8(127.13.131.131:33177)[L],e0bbb2dcb0ad4709a432dc47f88a3e0a(127.13.131.129:43321),ece09985778043cfb1b288b9fb40ba64(127.13.131.130:41683)]}]
15:57:27.002 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=18), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.13.131.188:37133, [9ms] Sub RPC GetTableLocations: received response from server master-127.13.131.188:37133: OK, deferred=null) after lookup
15:57:27.012 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 5d1bbfc5c8d84c69a2364d1332ad00b8(127.13.131.131:33177)] connecting to peer
15:57:27.013 [DEBUG - kudu-nio-1] (Connection.java:757) [peer 5d1bbfc5c8d84c69a2364d1332ad00b8(127.13.131.131:33177)] Successfully connected to peer
15:57:27.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:27.028451 14255 tablet.cc:2369] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a: Can't schedule compaction. Clean time has not been advanced past its initial value.
15:57:27.077 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x05fc4575, L:/127.0.0.1:58026 - R:/127.13.131.131:33177] using TOKEN/null
15:57:27.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.085155 14206 raft_consensus.cc:1261] T a4dbac32b95f43069590704182f065d6 P e0bbb2dcb0ad4709a432dc47f88a3e0a [term 1 FOLLOWER]: Refusing update from remote peer 5d1bbfc5c8d84c69a2364d1332ad00b8: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
15:57:27.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.085175 14341 raft_consensus.cc:1261] T a4dbac32b95f43069590704182f065d6 P ece09985778043cfb1b288b9fb40ba64 [term 1 FOLLOWER]: Refusing update from remote peer 5d1bbfc5c8d84c69a2364d1332ad00b8: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
15:57:27.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.086050 14560 consensus_queue.cc:1035] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [LEADER]: Connected to new peer: Peer: permanent_uuid: "ece09985778043cfb1b288b9fb40ba64" member_type: VOTER last_known_addr { host: "127.13.131.130" port: 41683 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
15:57:27.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.086278 14555 consensus_queue.cc:1035] T a4dbac32b95f43069590704182f065d6 P 5d1bbfc5c8d84c69a2364d1332ad00b8 [LEADER]: Connected to new peer: Peer: permanent_uuid: "e0bbb2dcb0ad4709a432dc47f88a3e0a" member_type: VOTER last_known_addr { host: "127.13.131.129" port: 43321 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
15:57:27.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.095173 14564 mvcc.cc:205] Tried to move back new op lower bound from 7305323508053147648 to 7305323507499778048. Current Snapshot: MvccSnapshot[applied={T|T < 7305323508053147648}]
15:57:27.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.099646 14565 mvcc.cc:205] Tried to move back new op lower bound from 7305323508053147648 to 7305323507499778048. Current Snapshot: MvccSnapshot[applied={T|T < 7305323508053147648}]
15:57:27.130 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
15:57:27.141 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
15:57:27.148 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
15:57:27.151 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1377813468(state=PENDING, result=null, callback=<none>, errback=<none>)}
15:57:27.161 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
15:57:27.162 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@993223321(state=PENDING, result=null, callback=<none>, errback=<none>)}
15:57:27.168 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
15:57:27.168 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1899300376(state=PENDING, result=null, callback=<none>, errback=<none>)}
15:57:27.174 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
15:57:27.217 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783526243995, tablet=a4dbac32b95f43069590704182f065d6, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
15:57:27.224 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305323528533147649) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783526243995, tablet=a4dbac32b95f43069590704182f065d6, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
15:57:27.229 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305323528533147653) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783526243995, tablet=a4dbac32b95f43069590704182f065d6, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
15:57:27.233 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305323528533147657) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783526243995, tablet=a4dbac32b95f43069590704182f065d6, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
15:57:27.237 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305323528533147661) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783526243995, tablet=a4dbac32b95f43069590704182f065d6, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
15:57:27.241 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305323528533147665) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783526243995, tablet=a4dbac32b95f43069590704182f065d6, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
15:57:27.245 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305323528533147669) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783526243995, tablet=a4dbac32b95f43069590704182f065d6, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
15:57:27.248 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305323528533147670) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783526243995, tablet=a4dbac32b95f43069590704182f065d6, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
15:57:27.252 [DEBUG - main] (Connection.java:575) [peer 5d1bbfc5c8d84c69a2364d1332ad00b8(127.13.131.131:33177)] disconnecting while in state READY
15:57:27.253 [DEBUG - main] (Connection.java:575) [peer master-127.13.131.188:37133(127.13.131.188:37133)] disconnecting while in state READY
15:57:27.253 [DEBUG - main] (Connection.java:575) [peer master-127.13.131.190:44151(127.13.131.190:44151)] disconnecting while in state READY
15:57:27.253 [DEBUG - main] (Connection.java:575) [peer master-127.13.131.189:41587(127.13.131.189:41587)] disconnecting while in state READY
15:57:27.258 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2704) Releasing all remaining resources
15:57:27.258 [DEBUG - kudu-nio-1] (Connection.java:239) [peer 5d1bbfc5c8d84c69a2364d1332ad00b8(127.13.131.131:33177)] handling channelInactive
15:57:27.259 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.13.131.188:37133(127.13.131.188:37133)] handling channelInactive
15:57:27.259 [DEBUG - kudu-nio-1] (Connection.java:709) [peer 5d1bbfc5c8d84c69a2364d1332ad00b8(127.13.131.131:33177)] cleaning up while in state READY due to: connection closed
15:57:27.259 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.13.131.190:44151(127.13.131.190:44151)] handling channelInactive
15:57:27.260 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.13.131.190:44151(127.13.131.190:44151)] cleaning up while in state READY due to: connection closed
15:57:27.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.259563 13838 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu with pid 14124
15:57:27.263 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.13.131.188:37133(127.13.131.188:37133)] cleaning up while in state READY due to: connection closed
15:57:27.263 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.13.131.189:41587(127.13.131.189:41587)] handling channelInactive
15:57:27.263 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.13.131.189:41587(127.13.131.189:41587)] cleaning up while in state READY due to: connection closed
15:57:27.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.267241 13838 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu with pid 14259
15:57:27.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.273872 13838 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu with pid 14394
15:57:27.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.280079 13838 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu with pid 13849
15:57:27.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.286022 13838 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu with pid 13918
15:57:27.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:27.292037 13838 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskzQ3kQc/build/debug/bin/kudu with pid 13990
15:57:27.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T15:57:27Z chronyd exiting

Time: 3.577

OK (1 test)

