JUnit version 4.13.2
.SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in [jar:file:/tmp/dist-test-taskmdTBqi/java/build/jars/log4j-slf4j-impl-2.17.1.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: Found binding in [jar:file:/tmp/dist-test-taskmdTBqi/java/build/jars/slf4j-log4j12-1.7.30.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory]
15:57:23.826 [INFO - main] (RandomUtils.java:49) Using random seed: 1783526243823
15:57:23.848 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
15:57:23.896 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
15:57:23.904 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskmdTBqi/test-tmp
15:57:23.907 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
15:57:23.909 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskmdTBqi/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
15:57:23.929 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

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

15:57:24.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.109843  9864 mini_oidc.cc:152] Starting JWKS server
15:57:24.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.112222  9864 webserver.cc:460] Webserver started at http://127.0.0.1:36735/ using document root <none> and password file <none>
15:57:24.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.112375  9864 mini_oidc.cc:189] Starting OIDC Discovery server
15:57:24.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.112635  9864 webserver.cc:460] Webserver started at http://127.0.0.1:41225/ using document root <none> and password file <none>
15:57:24.124 [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.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T15:57:24Z Disabled control of system clock
15:57:24.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.128764  9864 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:24.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:24.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/wal
15:57:24.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/data
15:57:24.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:24.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:24.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/logs
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/data/info.pb
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.62:38851
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.62
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:24.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36735/jwks.json with env {}
15:57:24.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.244124  9875 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:24.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.244433  9875 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:24.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.244474  9875 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:24.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.248886  9875 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
15:57:24.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.248976  9875 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:24.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.248998  9875 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
15:57:24.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.249017  9875 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
15:57:24.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.249035  9875 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
15:57:24.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.249050  9875 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:36735/jwks.json
15:57:24.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.254166  9875 master_runner.cc:386] Master server non-default flags:
15:57:24.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:24.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/data
15:57:24.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/wal
15:57:24.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:24.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.62:38851
15:57:24.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36735/jwks.json
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/data/info.pb
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.62
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.9875
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/logs
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:24.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:24.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
15:57:24.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:24.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:24.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:24.257 [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.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:24.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.255613  9875 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.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.257570  9875 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:24.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.267100  9881 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.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.267181  9875 server_base.cc:1034] running on GCE node
15:57:24.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.267127  9883 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.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.267112  9880 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.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.268044  9875 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:24.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.269294  9875 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:24.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.270453  9875 hybrid_clock.cc:648] HybridClock initialized: now 1783526244270378 us; error 97 us; skew 500 ppm
15:57:24.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.272346  9875 webserver.cc:460] Webserver started at http://127.9.162.62:38773/ using document root <none> and password file <none>
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.272905  9875 fs_manager.cc:359] Metadata directory not provided
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.272962  9875 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.273129  9875 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.275130  9875 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/data/instance:
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "016e9b34718245d8a8723ea8ed7641e4"
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-d6mh"
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.275730  9875 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/wal/instance:
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "016e9b34718245d8a8723ea8ed7641e4"
15:57:24.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-d6mh"
15:57:24.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.279500  9875 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.003s	sys 0.000s
15:57:24.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.281977  9889 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.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.283311  9875 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
15:57:24.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.283463  9875 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/data,/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/wal
15:57:24.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "016e9b34718245d8a8723ea8ed7641e4"
15:57:24.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-d6mh"
15:57:24.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.283555  9875 fs_report.cc:383] FS layout report
15:57:24.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:24.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/wal
15:57:24.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/wal
15:57:24.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/data/data
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:24.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:24.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:24.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.301729  9875 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:24.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.302455  9875 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.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.302609  9875 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:24.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.309710  9875 rpc_server.cc:307] RPC server started. Bound to: 127.9.162.62:38851
15:57:24.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.309729  9941 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.9.162.62:38851 every 8 connection(s)
15:57:24.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.310627  9875 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/data/info.pb
15:57:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.313850  9942 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.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.314790  9864 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu as pid 9875
15:57:24.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.314934  9864 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-0/wal/instance
15:57:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.316398  9864 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/wal
15:57:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/data
15:57:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/logs
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/data/info.pb
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.61:38117
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.61
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36735/jwks.json with env {}
15:57:24.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.317194  9942 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.330581  9942 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.331429  9890 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.9.162.61:38117: connect: Connection refused (error 111)
15:57:24.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.332492  9942 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.9.162.61:38117: Network error: Client connection negotiation failed: client connection to 127.9.162.61:38117: connect: Connection refused (error 111)
15:57:24.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.381763  9942 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } attempt: 1
15:57:24.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.383260  9942 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.9.162.61:38117: Network error: Client connection negotiation failed: client connection to 127.9.162.61:38117: connect: Connection refused (error 111)
15:57:24.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.430056  9944 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:24.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.430344  9944 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:24.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.430380  9944 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:24.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.434813  9944 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
15:57:24.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.434891  9944 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:24.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.434909  9944 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
15:57:24.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.434926  9944 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
15:57:24.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.434940  9944 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
15:57:24.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.434952  9944 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:36735/jwks.json
15:57:24.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.440704  9944 master_runner.cc:386] Master server non-default flags:
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/data
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/wal
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.61:38117
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36735/jwks.json
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/data/info.pb
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.61
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.9944
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/logs
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:24.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:24.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
15:57:24.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:24.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:24.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:24.443 [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.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:24.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.442083  9944 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.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.443810  9944 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:24.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.451416  9942 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } attempt: 2
15:57:24.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.451668  9953 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.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.451930  9944 server_base.cc:1034] running on GCE node
15:57:24.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.451684  9952 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.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.451723  9955 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.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.452761  9944 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:24.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.453572  9942 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.9.162.61:38117: Network error: Client connection negotiation failed: client connection to 127.9.162.61:38117: connect: Connection refused (error 111)
15:57:24.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.454200  9944 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:24.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.455415  9944 hybrid_clock.cc:648] HybridClock initialized: now 1783526244455372 us; error 57 us; skew 500 ppm
15:57:24.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.457396  9944 webserver.cc:460] Webserver started at http://127.9.162.61:36655/ using document root <none> and password file <none>
15:57:24.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.457917  9944 fs_manager.cc:359] Metadata directory not provided
15:57:24.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.457974  9944 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:24.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.458144  9944 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:24.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.460071  9944 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/data/instance:
15:57:24.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0f2ee915e5814b87ad09c7df00ebb9a3"
15:57:24.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-d6mh"
15:57:24.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.460588  9944 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/wal/instance:
15:57:24.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0f2ee915e5814b87ad09c7df00ebb9a3"
15:57:24.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-d6mh"
15:57:24.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.464604  9944 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
15:57:24.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.467545  9961 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.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.468848  9944 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
15:57:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.468955  9944 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/data,/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/wal
15:57:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0f2ee915e5814b87ad09c7df00ebb9a3"
15:57:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-d6mh"
15:57:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.469039  9944 fs_report.cc:383] FS layout report
15:57:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/wal
15:57:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/wal
15:57:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/data/data
15:57:24.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:24.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:24.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:24.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:24.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:24.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:24.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:24.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:24.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:24.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:24.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:24.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.485746  9944 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:24.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.486456  9944 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.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.486644  9944 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:24.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.493952  9944 rpc_server.cc:307] RPC server started. Bound to: 127.9.162.61:38117
15:57:24.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.493963 10013 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.9.162.61:38117 every 8 connection(s)
15:57:24.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.494987  9944 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/data/info.pb
15:57:24.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.498337 10014 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.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.502084 10014 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.503201  9864 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu as pid 9944
15:57:24.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.503289  9864 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-1/wal/instance
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.503826  9864 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/wal
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/data
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/logs
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/data/info.pb
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:24.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.60:41659
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.60
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:24.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36735/jwks.json with env {}
15:57:24.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.515911 10014 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.522605 10014 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.523432  9963 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.9.162.60:41659: connect: Connection refused (error 111)
15:57:24.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.524586 10014 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.9.162.60:41659: Network error: Client connection negotiation failed: client connection to 127.9.162.60:41659: connect: Connection refused (error 111)
15:57:24.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.544759  9942 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } attempt: 3
15:57:24.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.549564  9942 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.550724  9942 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.9.162.60:41659: Network error: Client connection negotiation failed: client connection to 127.9.162.60:41659: connect: Connection refused (error 111)
15:57:24.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.573810 10014 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } attempt: 1
15:57:24.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.575282 10014 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.9.162.60:41659: Network error: Client connection negotiation failed: client connection to 127.9.162.60:41659: connect: Connection refused (error 111)
15:57:24.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.581876  9942 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } attempt: 1
15:57:24.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.583041  9942 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.9.162.60:41659: Network error: Client connection negotiation failed: client connection to 127.9.162.60:41659: connect: Connection refused (error 111)
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.619750 10016 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.620042 10016 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:24.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.620096 10016 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:24.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.624567 10016 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
15:57:24.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.624639 10016 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:24.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.624663 10016 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
15:57:24.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.624682 10016 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
15:57:24.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.624703 10016 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
15:57:24.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.624719 10016 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:36735/jwks.json
15:57:24.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.629675 10016 master_runner.cc:386] Master server non-default flags:
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/data
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/wal
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.60:41659
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36735/jwks.json
15:57:24.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/data/info.pb
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.60
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.10016
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/logs
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:24.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
15:57:24.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:24.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:24.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:24.632 [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.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:24.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.631132 10016 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.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.632941 10016 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:24.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.641170 10025 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.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.641412 10016 server_base.cc:1034] running on GCE node
15:57:24.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.641669 10027 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.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.641176 10024 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.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.642433 10016 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:24.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.643476 10014 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } attempt: 2
15:57:24.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.643719 10016 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:24.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.644968 10014 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.9.162.60:41659: Network error: Client connection negotiation failed: client connection to 127.9.162.60:41659: connect: Connection refused (error 111)
15:57:24.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.647068 10016 hybrid_clock.cc:648] HybridClock initialized: now 1783526244646990 us; error 92 us; skew 500 ppm
15:57:24.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.649137 10016 webserver.cc:460] Webserver started at http://127.9.162.60:46549/ using document root <none> and password file <none>
15:57:24.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.649775 10016 fs_manager.cc:359] Metadata directory not provided
15:57:24.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.649847 10016 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:24.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.650087 10016 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:24.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.652215 10016 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/data/instance:
15:57:24.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1ddf4bf4e0f04b298b1927f603e54e64"
15:57:24.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-d6mh"
15:57:24.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.652817 10016 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/wal/instance:
15:57:24.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1ddf4bf4e0f04b298b1927f603e54e64"
15:57:24.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-d6mh"
15:57:24.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.656760 10016 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
15:57:24.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.658216  9942 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } attempt: 2
15:57:24.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.659677 10033 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.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.659859  9942 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.9.162.60:41659: Network error: Client connection negotiation failed: client connection to 127.9.162.60:41659: connect: Connection refused (error 111)
15:57:24.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.661441 10016 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
15:57:24.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.661550 10016 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/data,/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/wal
15:57:24.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1ddf4bf4e0f04b298b1927f603e54e64"
15:57:24.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-d6mh"
15:57:24.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.661646 10016 fs_report.cc:383] FS layout report
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/wal
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/wal
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/data/data
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:24.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:24.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.696041 10016 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:24.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.696818 10016 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.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.697014 10016 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:24.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.704795 10016 rpc_server.cc:307] RPC server started. Bound to: 127.9.162.60:41659
15:57:24.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.704808 10085 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.9.162.60:41659 every 8 connection(s)
15:57:24.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.705998 10016 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/data/info.pb
15:57:24.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.709367 10086 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.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.710206  9864 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu as pid 10016
15:57:24.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.710307  9864 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/master-2/wal/instance
15:57:24.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.713480 10086 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.724443 10086 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.729485 10086 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } has no permanent_uuid. Determining permanent_uuid...
15:57:24.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.736027 10086 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64: Bootstrap starting.
15:57:24.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.736135 10014 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } attempt: 3
15:57:24.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.738958 10086 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64: Neither blocks nor log segments found. Creating new log.
15:57:24.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.740806 10086 log.cc:824] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64: Log is configured to *not* fsync() on all Append() calls
15:57:24.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.743033 10086 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64: No bootstrap required, opened a new log
15:57:24.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.743856 10014 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3: Bootstrap starting.
15:57:24.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.746280 10014 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3: Neither blocks nor log segments found. Creating new log.
15:57:24.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.746421 10086 raft_consensus.cc:348] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } }
15:57:24.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.746634 10086 raft_consensus.cc:374] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:24.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.746667 10086 raft_consensus.cc:729] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 1ddf4bf4e0f04b298b1927f603e54e64, State: Initialized, Role: FOLLOWER
15:57:24.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.747033 10086 consensus_queue.cc:260] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [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: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } }
15:57:24.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.747483 10095 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [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: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } } }
15:57:24.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.747812 10095 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [sys.catalog]: This master's current role is: FOLLOWER
15:57:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.748142 10014 log.cc:824] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3: Log is configured to *not* fsync() on all Append() calls
15:57:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.748417 10086 sys_catalog.cc:564] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [sys.catalog]: configured and running, proceeding with master startup.
15:57:24.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.751448 10014 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3: No bootstrap required, opened a new log
15:57:24.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.754182 10107 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
15:57:24.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.754515 10107 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
15:57:24.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.753855 10016 master_runner.cc:186] Error getting master registration for 127.9.162.62:38851: OK, instance_id { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" instance_seqno: 1783526244307951 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
15:57:24.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.757323 10016 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
15:57:24.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.759002  9942 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } attempt: 3
15:57:24.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.759056 10014 raft_consensus.cc:348] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } }
15:57:24.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.759328 10014 raft_consensus.cc:374] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:24.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.759404 10014 raft_consensus.cc:729] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 0f2ee915e5814b87ad09c7df00ebb9a3, State: Initialized, Role: FOLLOWER
15:57:24.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.759987 10014 consensus_queue.cc:260] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [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: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } }
15:57:24.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.761545 10014 sys_catalog.cc:564] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [sys.catalog]: configured and running, proceeding with master startup.
15:57:24.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.767673  9942 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4: Bootstrap starting.
15:57:24.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.765331  9944 master_runner.cc:186] Error getting master registration for 127.9.162.62:38851: OK, instance_id { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" instance_seqno: 1783526244307951 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
15:57:24.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.769055  9944 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
15:57:24.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.770620  9942 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4: Neither blocks nor log segments found. Creating new log.
15:57:24.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.772434 10109 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [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: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } } }
15:57:24.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.772590 10109 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [sys.catalog]: This master's current role is: FOLLOWER
15:57:24.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.773257 10120 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
15:57:24.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.773362 10120 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
15:57:24.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.775027  9942 log.cc:824] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4: Log is configured to *not* fsync() on all Append() calls
15:57:24.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.777660  9942 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4: No bootstrap required, opened a new log
15:57:24.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.781064  9942 raft_consensus.cc:348] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } }
15:57:24.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.781275  9942 raft_consensus.cc:374] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:24.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.781329  9942 raft_consensus.cc:729] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 016e9b34718245d8a8723ea8ed7641e4, State: Initialized, Role: FOLLOWER
15:57:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.781857  9942 consensus_queue.cc:260] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [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: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } }
15:57:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.782366 10123 sys_catalog.cc:455] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [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: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } } }
15:57:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.782655 10123 sys_catalog.cc:458] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [sys.catalog]: This master's current role is: FOLLOWER
15:57:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.783318  9942 sys_catalog.cc:564] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [sys.catalog]: configured and running, proceeding with master startup.
15:57:24.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.792752  9875 master_runner.cc:263] No leader master found from master 016e9b34718245d8a8723ea8ed7641e4
15:57:24.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.792850  9875 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
15:57:24.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.795884 10134 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
15:57:24.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.798544 10134 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
15:57:24.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.804189  9895 tablet.cc:2369] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4: Can't schedule compaction. Clean time has not been advanced past its initial value.
15:57:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.883637 10095 raft_consensus.cc:482] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
15:57:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.883837 10095 raft_consensus.cc:504] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } }
15:57:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.884954 10095 leader_election.cc:288] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 016e9b34718245d8a8723ea8ed7641e4 (127.9.162.62:38851), 0f2ee915e5814b87ad09c7df00ebb9a3 (127.9.162.61:38117)
15:57:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.885727  9988 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" is_pre_election: true
15:57:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.886040  9988 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 1ddf4bf4e0f04b298b1927f603e54e64 in term 0.
15:57:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.886878  9916 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "016e9b34718245d8a8723ea8ed7641e4" is_pre_election: true
15:57:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.887179  9916 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 1ddf4bf4e0f04b298b1927f603e54e64 in term 0.
15:57:24.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.887763 10034 leader_election.cc:302] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [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: 0f2ee915e5814b87ad09c7df00ebb9a3, 1ddf4bf4e0f04b298b1927f603e54e64; no voters: 
15:57:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.889407 10095 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [term 0 FOLLOWER]: Leader pre-election won for term 1
15:57:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.889523 10095 raft_consensus.cc:482] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
15:57:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.889567 10095 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [term 0 FOLLOWER]: Advancing to term 1
15:57:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.890822 10095 raft_consensus.cc:504] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } }
15:57:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.891201 10095 leader_election.cc:288] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [CANDIDATE]: Term 1 election: Requested vote from peers 016e9b34718245d8a8723ea8ed7641e4 (127.9.162.62:38851), 0f2ee915e5814b87ad09c7df00ebb9a3 (127.9.162.61:38117)
15:57:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.891969  9916 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "016e9b34718245d8a8723ea8ed7641e4"
15:57:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.892092  9916 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [term 0 FOLLOWER]: Advancing to term 1
15:57:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.893541  9916 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 1ddf4bf4e0f04b298b1927f603e54e64 in term 1.
15:57:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.893908 10035 leader_election.cc:302] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [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: 016e9b34718245d8a8723ea8ed7641e4, 1ddf4bf4e0f04b298b1927f603e54e64; no voters: 
15:57:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.894153  9988 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3"
15:57:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.894280  9988 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [term 0 FOLLOWER]: Advancing to term 1
15:57:24.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.896585  9988 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 1ddf4bf4e0f04b298b1927f603e54e64 in term 1.
15:57:24.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.903520 10095 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [term 1 FOLLOWER]: Leader election won for term 1
15:57:24.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.903808 10095 raft_consensus.cc:686] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [term 1 LEADER]: Becoming Leader. State: Replica: 1ddf4bf4e0f04b298b1927f603e54e64, State: Running, Role: LEADER
15:57:24.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.904174 10095 consensus_queue.cc:237] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [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: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } }
15:57:24.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.911491 10095 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 1ddf4bf4e0f04b298b1927f603e54e64. Latest consensus state: current_term: 1 leader_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } } }
15:57:24.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.911988 10095 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [sys.catalog]: This master's current role is: LEADER
15:57:24.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.915400 10138 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
15:57:24.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.920477 10138 catalog_manager.cc:1484] Initializing Kudu cluster ID...
15:57:24.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.930126  9988 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [term 1 FOLLOWER]: Refusing update from remote peer 1ddf4bf4e0f04b298b1927f603e54e64: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
15:57:24.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.932590 10136 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [LEADER]: Connected to new peer: Peer: permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
15:57:24.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.938189 10109 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 1ddf4bf4e0f04b298b1927f603e54e64. Latest consensus state: current_term: 1 leader_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } } }
15:57:24.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.938338 10109 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [sys.catalog]: This master's current role is: FOLLOWER
15:57:24.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.941108  9916 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [term 1 FOLLOWER]: Refusing update from remote peer 1ddf4bf4e0f04b298b1927f603e54e64: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
15:57:24.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.942209 10136 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [LEADER]: Connected to new peer: Peer: permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
15:57:24.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.946935 10123 sys_catalog.cc:455] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 1ddf4bf4e0f04b298b1927f603e54e64. Latest consensus state: current_term: 1 leader_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } } }
15:57:24.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.947075 10123 sys_catalog.cc:458] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [sys.catalog]: This master's current role is: FOLLOWER
15:57:24.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.951524 10039 tablet.cc:2369] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64: Can't schedule compaction. Clean time has not been advanced past its initial value.
15:57:24.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.962700 10136 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } } }
15:57:24.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.962862 10136 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [sys.catalog]: This master's current role is: LEADER
15:57:24.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.962985 10136 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } } }
15:57:24.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.963058 10136 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64 [sys.catalog]: This master's current role is: LEADER
15:57:24.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.963076 10109 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } } }
15:57:24.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.963204 10109 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3 [sys.catalog]: This master's current role is: FOLLOWER
15:57:24.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.963188 10139 mvcc.cc:205] Tried to move back new op lower bound from 7305323499218726912 to 7305323499140112384. Current Snapshot: MvccSnapshot[applied={T|T < 7305323499218726912}]
15:57:24.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.964120 10123 sys_catalog.cc:455] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "016e9b34718245d8a8723ea8ed7641e4" member_type: VOTER last_known_addr { host: "127.9.162.62" port: 38851 } } peers { permanent_uuid: "0f2ee915e5814b87ad09c7df00ebb9a3" member_type: VOTER last_known_addr { host: "127.9.162.61" port: 38117 } } peers { permanent_uuid: "1ddf4bf4e0f04b298b1927f603e54e64" member_type: VOTER last_known_addr { host: "127.9.162.60" port: 41659 } } }
15:57:24.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.964237 10123 sys_catalog.cc:458] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4 [sys.catalog]: This master's current role is: FOLLOWER
15:57:24.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.965219 10138 catalog_manager.cc:1347] Generated new cluster ID: c7b8d42bcfd74e3dbfb7027150636c37
15:57:24.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.965271 10138 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
15:57:24.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.966157 10142 mvcc.cc:205] Tried to move back new op lower bound from 7305323499218726912 to 7305323499140112384. Current Snapshot: MvccSnapshot[applied={T|T < 7305323499218726912}]
15:57:24.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.981325 10138 catalog_manager.cc:1370] Generated new certificate authority record
15:57:24.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.982662 10138 catalog_manager.cc:1504] Loading token signing keys...
15:57:24.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.990317 10138 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 1ddf4bf4e0f04b298b1927f603e54e64: Generated new TSK 0
15:57:24.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.991765 10138 catalog_manager.cc:1514] Initializing in-progress tserver states...
15:57:25.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.014722  9864 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/wal
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/data
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/logs
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/data/info.pb
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.1:0
15:57:25.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.162.1
15:57:25.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.1
15:57:25.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:25.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:25.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
15:57:25.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.129307 10148 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:25.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.129601 10148 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:25.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.129637 10148 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:25.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.133697 10148 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:25.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.133795 10148 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.9.162.1
15:57:25.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.138520 10148 tablet_server_runner.cc:78] Tablet server non-default flags:
15:57:25.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/data
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/wal
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.1:0
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/data/info.pb
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.1
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.10148
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.162.1
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/logs
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:25.139 [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.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:25.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.139775 10148 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.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.141155 10148 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:25.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.151691 10148 server_base.cc:1034] running on GCE node
15:57:25.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.151645 10153 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.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.151645 10156 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.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.151648 10154 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.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.152520 10148 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:25.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.153126 10148 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:25.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.154285 10148 hybrid_clock.cc:648] HybridClock initialized: now 1783526245154260 us; error 41 us; skew 500 ppm
15:57:25.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.156700 10148 webserver.cc:460] Webserver started at http://127.9.162.1:33907/ using document root <none> and password file <none>
15:57:25.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.157322 10148 fs_manager.cc:359] Metadata directory not provided
15:57:25.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.157393 10148 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:25.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.157630 10148 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:25.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.159711 10148 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/data/instance:
15:57:25.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f4550fe7ed2a4afa9de03f12a21431b5"
15:57:25.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-d6mh"
15:57:25.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.160296 10148 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/wal/instance:
15:57:25.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f4550fe7ed2a4afa9de03f12a21431b5"
15:57:25.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-d6mh"
15:57:25.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.164316 10148 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
15:57:25.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.166823 10162 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.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.168459 10148 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
15:57:25.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.168570 10148 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/data,/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/wal
15:57:25.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f4550fe7ed2a4afa9de03f12a21431b5"
15:57:25.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-d6mh"
15:57:25.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.168665 10148 fs_report.cc:383] FS layout report
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/wal
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/wal
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/data/data
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:25.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.192761 10148 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:25.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.193430 10148 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.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.193595 10148 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:25.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.194126 10148 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:57:25.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.195307 10148 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:57:25.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.195386 10148 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:57:25.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.195441 10148 ts_tablet_manager.cc:610] Registered 0 tablets
15:57:25.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.195456 10148 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:57:25.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.204530 10148 rpc_server.cc:307] RPC server started. Bound to: 127.9.162.1:46165
15:57:25.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.204566 10275 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.9.162.1:46165 every 8 connection(s)
15:57:25.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.205453 10148 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/data/info.pb
15:57:25.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.210472  9864 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu as pid 10148
15:57:25.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.210595  9864 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-0/wal/instance
15:57:25.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.216384  9864 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:25.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:25.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/wal
15:57:25.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/data
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/logs
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/data/info.pb
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.2:0
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.162.2
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.2
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.218640 10277 heartbeater.cc:347] Connected to a master server at 127.9.162.62:38851
15:57:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.218894 10277 heartbeater.cc:464] Registering TS with master...
15:57:25.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.219631 10277 heartbeater.cc:511] Master 127.9.162.62:38851 requested a full tablet report, sending...
15:57:25.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.220443 10276 heartbeater.cc:347] Connected to a master server at 127.9.162.60:41659
15:57:25.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.220888 10276 heartbeater.cc:464] Registering TS with master...
15:57:25.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.221026 10278 heartbeater.cc:347] Connected to a master server at 127.9.162.61:38117
15:57:25.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.221102 10278 heartbeater.cc:464] Registering TS with master...
15:57:25.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.221277 10278 heartbeater.cc:511] Master 127.9.162.61:38117 requested a full tablet report, sending...
15:57:25.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.221253  9906 ts_manager.cc:194] Registered new tserver with Master: f4550fe7ed2a4afa9de03f12a21431b5 (127.9.162.1:46165)
15:57:25.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.223591 10276 heartbeater.cc:511] Master 127.9.162.60:41659 requested a full tablet report, sending...
15:57:25.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.223613  9978 ts_manager.cc:194] Registered new tserver with Master: f4550fe7ed2a4afa9de03f12a21431b5 (127.9.162.1:46165)
15:57:25.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.225236 10050 ts_manager.cc:194] Registered new tserver with Master: f4550fe7ed2a4afa9de03f12a21431b5 (127.9.162.1:46165)
15:57:25.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.226871 10050 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.9.162.1:56039
15:57:25.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.335105 10283 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:25.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.335424 10283 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:25.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.335462 10283 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:25.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.339871 10283 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:25.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.339984 10283 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.9.162.2
15:57:25.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.344738 10283 tablet_server_runner.cc:78] Tablet server non-default flags:
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/data
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/wal
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.2:0
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/data/info.pb
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.2
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.10283
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.162.2
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/logs
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:25.345 [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.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:25.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.345824 10283 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.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.347271 10283 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:25.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.356894 10288 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.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.356886 10289 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.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.357074 10283 server_base.cc:1034] running on GCE node
15:57:25.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.356886 10291 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.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.357805 10283 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:25.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.358484 10283 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:25.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.359652 10283 hybrid_clock.cc:648] HybridClock initialized: now 1783526245359625 us; error 42 us; skew 500 ppm
15:57:25.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.361479 10283 webserver.cc:460] Webserver started at http://127.9.162.2:46821/ using document root <none> and password file <none>
15:57:25.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.362051 10283 fs_manager.cc:359] Metadata directory not provided
15:57:25.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.362116 10283 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:25.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.362283 10283 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:25.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.364447 10283 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/data/instance:
15:57:25.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "88b5f97aa23b4ceca45a4a7501aec740"
15:57:25.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-d6mh"
15:57:25.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.364977 10283 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/wal/instance:
15:57:25.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "88b5f97aa23b4ceca45a4a7501aec740"
15:57:25.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-d6mh"
15:57:25.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.368928 10283 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
15:57:25.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.371354 10297 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.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.372694 10283 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
15:57:25.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.372797 10283 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/data,/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/wal
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "88b5f97aa23b4ceca45a4a7501aec740"
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-d6mh"
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.372898 10283 fs_report.cc:383] FS layout report
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/wal
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/wal
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/data/data
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:25.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.400758 10283 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:25.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.401445 10283 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.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.401618 10283 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:25.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.402163 10283 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:57:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.403153 10283 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:57:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.403201 10283 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:57:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.403240 10283 ts_tablet_manager.cc:610] Registered 0 tablets
15:57:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.403254 10283 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:57:25.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.412734 10283 rpc_server.cc:307] RPC server started. Bound to: 127.9.162.2:41957
15:57:25.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.413223 10410 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.9.162.2:41957 every 8 connection(s)
15:57:25.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.413662 10283 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/data/info.pb
15:57:25.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.415398  9864 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu as pid 10283
15:57:25.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.415489  9864 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-1/wal/instance
15:57:25.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.418529  9864 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:25.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu
15:57:25.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/wal
15:57:25.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/data
15:57:25.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:25.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/logs
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/data/info.pb
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.3:0
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.162.3
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.3
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
15:57:25.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.427503 10412 heartbeater.cc:347] Connected to a master server at 127.9.162.62:38851
15:57:25.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.427553 10413 heartbeater.cc:347] Connected to a master server at 127.9.162.61:38117
15:57:25.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.427747 10413 heartbeater.cc:464] Registering TS with master...
15:57:25.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.427747 10412 heartbeater.cc:464] Registering TS with master...
15:57:25.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.428462 10412 heartbeater.cc:511] Master 127.9.162.62:38851 requested a full tablet report, sending...
15:57:25.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.427771 10411 heartbeater.cc:347] Connected to a master server at 127.9.162.60:41659
15:57:25.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.428460 10413 heartbeater.cc:511] Master 127.9.162.61:38117 requested a full tablet report, sending...
15:57:25.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.428640 10411 heartbeater.cc:464] Registering TS with master...
15:57:25.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.428792 10411 heartbeater.cc:511] Master 127.9.162.60:41659 requested a full tablet report, sending...
15:57:25.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.429759  9978 ts_manager.cc:194] Registered new tserver with Master: 88b5f97aa23b4ceca45a4a7501aec740 (127.9.162.2:41957)
15:57:25.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.430110  9906 ts_manager.cc:194] Registered new tserver with Master: 88b5f97aa23b4ceca45a4a7501aec740 (127.9.162.2:41957)
15:57:25.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.430176 10050 ts_manager.cc:194] Registered new tserver with Master: 88b5f97aa23b4ceca45a4a7501aec740 (127.9.162.2:41957)
15:57:25.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.430935 10050 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.9.162.2:46953
15:57:25.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.537812 10418 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:25.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.538111 10418 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:25.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.538147 10418 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:25.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.542219 10418 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:25.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.542328 10418 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.9.162.3
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.547021 10418 tablet_server_runner.cc:78] Tablet server non-default flags:
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.162.20:33399
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/data
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/wal
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.162.3:0
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/data/info.pb
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.162.3
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.162.62:38851,127.9.162.61:38117,127.9.162.60:41659
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.10418
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.162.3
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/logs
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:25.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:25.547 [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.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:25.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.548154 10418 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.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.549513 10418 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:25.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.558945 10423 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.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.559022 10418 server_base.cc:1034] running on GCE node
15:57:25.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.558956 10424 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.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.558986 10426 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.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.559639 10418 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:25.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.560297 10418 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:25.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.561434 10418 hybrid_clock.cc:648] HybridClock initialized: now 1783526245561412 us; error 56 us; skew 500 ppm
15:57:25.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.563392 10418 webserver.cc:460] Webserver started at http://127.9.162.3:33711/ using document root <none> and password file <none>
15:57:25.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.563943 10418 fs_manager.cc:359] Metadata directory not provided
15:57:25.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.564007 10418 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:25.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.564169 10418 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.566157 10418 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/data/instance:
15:57:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c5ae16a14ae647a6a45fba7c6af37b62"
15:57:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-d6mh"
15:57:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.566715 10418 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/wal/instance:
15:57:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c5ae16a14ae647a6a45fba7c6af37b62"
15:57:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-d6mh"
15:57:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.570380 10418 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.006s	sys 0.000s
15:57:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.572894 10432 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.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.574323 10418 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.000s
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.574445 10418 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/data,/tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/wal
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c5ae16a14ae647a6a45fba7c6af37b62"
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-d6mh"
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.574568 10418 fs_report.cc:383] FS layout report
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/wal
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/wal
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/data/data
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:25.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.594110 10418 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:25.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.595207 10418 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.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.595418 10418 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:25.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.596036 10418 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:57:25.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.596997 10418 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:57:25.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.597041 10418 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:57:25.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.597080 10418 ts_tablet_manager.cc:610] Registered 0 tablets
15:57:25.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.597095 10418 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.606453 10418 rpc_server.cc:307] RPC server started. Bound to: 127.9.162.3:44675
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.606480 10545 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.9.162.3:44675 every 8 connection(s)
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.607401 10418 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/data/info.pb
15:57:25.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.616611  9864 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu as pid 10418
15:57:25.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.616727  9864 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskmdTBqi/test-tmp/mini-kudu-cluster494604458503143952/ts-2/wal/instance
15:57:25.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.618634 10548 heartbeater.cc:347] Connected to a master server at 127.9.162.61:38117
15:57:25.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.618682 10547 heartbeater.cc:347] Connected to a master server at 127.9.162.62:38851
15:57:25.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.618686 10546 heartbeater.cc:347] Connected to a master server at 127.9.162.60:41659
15:57:25.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.619061 10548 heartbeater.cc:464] Registering TS with master...
15:57:25.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.619060 10547 heartbeater.cc:464] Registering TS with master...
15:57:25.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.619060 10546 heartbeater.cc:464] Registering TS with master...
15:57:25.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.619699 10546 heartbeater.cc:511] Master 127.9.162.60:41659 requested a full tablet report, sending...
15:57:25.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.619701 10548 heartbeater.cc:511] Master 127.9.162.61:38117 requested a full tablet report, sending...
15:57:25.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.620213 10547 heartbeater.cc:511] Master 127.9.162.62:38851 requested a full tablet report, sending...
15:57:25.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.620791  9978 ts_manager.cc:194] Registered new tserver with Master: c5ae16a14ae647a6a45fba7c6af37b62 (127.9.162.3:44675)
15:57:25.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.620960 10050 ts_manager.cc:194] Registered new tserver with Master: c5ae16a14ae647a6a45fba7c6af37b62 (127.9.162.3:44675)
15:57:25.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.621438  9906 ts_manager.cc:194] Registered new tserver with Master: c5ae16a14ae647a6a45fba7c6af37b62 (127.9.162.3:44675)
15:57:25.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.621666 10050 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.9.162.3:47465
15:57:25.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.634904  9864 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
15:57:25.635 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
15:57:25.636 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

15:57:25.645 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.9.162.62"
      port: 38851
    }
    bound_http_address {
      host: "127.9.162.62"
      port: 38773
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.9.162.61"
      port: 38117
    }
    bound_http_address {
      host: "127.9.162.61"
      port: 36655
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.9.162.60"
      port: 41659
    }
    bound_http_address {
      host: "127.9.162.60"
      port: 46549
    }
  }
}

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

15:57:25.654 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.9.162.1"
      port: 46165
    }
    bound_http_address {
      host: "127.9.162.1"
      port: 33907
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.9.162.2"
      port: 41957
    }
    bound_http_address {
      host: "127.9.162.2"
      port: 46821
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.9.162.3"
      port: 44675
    }
    bound_http_address {
      host: "127.9.162.3"
      port: 33711
    }
  }
}

15:57:25.658 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
15:57:25.668 [DEBUG - main] (InternalLoggerFactory.java:63) Using SLF4J as the default logging framework
15:57:25.674 [DEBUG - main] (ResourceLeakDetector.java:129) -Dorg.apache.kudu.shaded.io.netty.leakDetection.level: simple
15:57:25.674 [DEBUG - main] (ResourceLeakDetector.java:130) -Dorg.apache.kudu.shaded.io.netty.leakDetection.targetRecords: 4
15:57:25.679 [DEBUG - main] (ResourceLeakDetectorFactory.java:196) Loaded default ResourceLeakDetector: org.apache.kudu.shaded.io.netty.util.ResourceLeakDetector@68044f4
15:57:25.698 [DEBUG - main] (PlatformDependent0.java:497) -Dio.netty.noUnsafe: false
15:57:25.698 [DEBUG - main] (PlatformDependent0.java:1001) Java version: 8
15:57:25.699 [DEBUG - main] (PlatformDependent0.java:137) sun.misc.Unsafe.theUnsafe: available
15:57:25.699 [DEBUG - main] (PlatformDependent0.java:161) sun.misc.Unsafe.copyMemory: available
15:57:25.700 [DEBUG - main] (PlatformDependent0.java:193) sun.misc.Unsafe.storeFence: available
15:57:25.700 [DEBUG - main] (PlatformDependent0.java:236) java.nio.Buffer.address: available
15:57:25.700 [DEBUG - main] (PlatformDependent0.java:308) direct buffer constructor: available
15:57:25.701 [DEBUG - main] (PlatformDependent0.java:386) java.nio.Bits.unaligned: available, true
15:57:25.701 [DEBUG - main] (PlatformDependent0.java:460) jdk.internal.misc.Unsafe.allocateUninitializedArray(int): unavailable prior to Java9
15:57:25.701 [DEBUG - main] (PlatformDependent0.java:483) java.nio.DirectByteBuffer.<init>(long, {int,long}): available
15:57:25.701 [DEBUG - main] (PlatformDependent.java:1159) sun.misc.Unsafe: available
15:57:25.702 [DEBUG - main] (PlatformDependent.java:1289) -Dio.netty.tmpdir: /tmp (java.io.tmpdir)
15:57:25.702 [DEBUG - main] (PlatformDependent.java:1368) -Dio.netty.bitMode: 64 (sun.arch.data.model)
15:57:25.703 [DEBUG - main] (PlatformDependent.java:178) -Dio.netty.maxDirectMemory: 3799121920 bytes
15:57:25.703 [DEBUG - main] (PlatformDependent.java:185) -Dio.netty.uninitializedArrayAllocationThreshold: -1
15:57:25.704 [DEBUG - main] (CleanerJava6.java:92) java.nio.ByteBuffer.cleaner(): available
15:57:25.704 [DEBUG - main] (PlatformDependent.java:205) -Dio.netty.noPreferDirect: false
15:57:25.711 [DEBUG - main] (PlatformDependent.java:1010) org.jctools-core.MpscChunkedArrayQueue: available
15:57:25.747 [DEBUG - main] (MultithreadEventLoopGroup.java:44) -Dio.netty.eventLoopThreads: 2
15:57:25.760 [DEBUG - main] (GlobalEventExecutor.java:53) -Dio.netty.globalEventExecutor.quietPeriodSeconds: 1
15:57:25.766 [DEBUG - main] (InternalThreadLocalMap.java:100) -Dio.netty.threadLocalMap.stringBuilder.initialSize: 1024
15:57:25.766 [DEBUG - main] (InternalThreadLocalMap.java:101) -Dio.netty.threadLocalMap.stringBuilder.maxSize: 4096
15:57:25.773 [DEBUG - main] (NioEventLoop.java:110) -Dio.netty.noKeySetOptimization: false
15:57:25.773 [DEBUG - main] (NioEventLoop.java:111) -Dio.netty.selectorAutoRebuildThreshold: 512
15:57:25.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.775007 10120 catalog_manager.cc:1259] Loaded cluster ID: c7b8d42bcfd74e3dbfb7027150636c37
15:57:25.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.775095 10120 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3: loading cluster ID for follower catalog manager: success
15:57:25.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.777704 10120 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3: acquiring CA information for follower catalog manager: success
15:57:25.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.779383 10120 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 0f2ee915e5814b87ad09c7df00ebb9a3: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
15:57:25.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.800683 10134 catalog_manager.cc:1259] Loaded cluster ID: c7b8d42bcfd74e3dbfb7027150636c37
15:57:25.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.800760 10134 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4: loading cluster ID for follower catalog manager: success
15:57:25.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.802572 10134 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4: acquiring CA information for follower catalog manager: success
15:57:25.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.803993 10134 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 016e9b34718245d8a8723ea8ed7641e4: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
15:57:25.816 [DEBUG - main] (PooledByteBufAllocator.java:157) -Dio.netty.allocator.numHeapArenas: 2
15:57:25.817 [DEBUG - main] (PooledByteBufAllocator.java:158) -Dio.netty.allocator.numDirectArenas: 2
15:57:25.817 [DEBUG - main] (PooledByteBufAllocator.java:160) -Dio.netty.allocator.pageSize: 8192
15:57:25.817 [DEBUG - main] (PooledByteBufAllocator.java:165) -Dio.netty.allocator.maxOrder: 9
15:57:25.817 [DEBUG - main] (PooledByteBufAllocator.java:169) -Dio.netty.allocator.chunkSize: 4194304
15:57:25.817 [DEBUG - main] (PooledByteBufAllocator.java:170) -Dio.netty.allocator.smallCacheSize: 256
15:57:25.817 [DEBUG - main] (PooledByteBufAllocator.java:171) -Dio.netty.allocator.normalCacheSize: 64
15:57:25.817 [DEBUG - main] (PooledByteBufAllocator.java:172) -Dio.netty.allocator.maxCachedBufferCapacity: 32768
15:57:25.817 [DEBUG - main] (PooledByteBufAllocator.java:173) -Dio.netty.allocator.cacheTrimInterval: 8192
15:57:25.817 [DEBUG - main] (PooledByteBufAllocator.java:174) -Dio.netty.allocator.cacheTrimIntervalMillis: 0
15:57:25.818 [DEBUG - main] (PooledByteBufAllocator.java:175) -Dio.netty.allocator.useCacheForAllThreads: false
15:57:25.818 [DEBUG - main] (PooledByteBufAllocator.java:176) -Dio.netty.allocator.maxCachedByteBuffersPerChunk: 1023
15:57:25.853 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
15:57:25.978 [INFO - main] (Logging.scala:57) Running Spark version 3.1.2
15:57:26.198 [WARN - main] (NativeCodeLoader.java:60) Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
15:57:26.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.229234 10276 heartbeater.cc:503] Master 127.9.162.60:41659 was elected leader, sending a full tablet report...
15:57:26.315 [INFO - main] (Logging.scala:57) ==============================================================
15:57:26.315 [INFO - main] (Logging.scala:57) No custom resources configured for spark.driver.
15:57:26.316 [INFO - main] (Logging.scala:57) ==============================================================
15:57:26.317 [INFO - main] (Logging.scala:57) Submitted application: test
15:57:26.350 [INFO - main] (Logging.scala:57) Default ResourceProfile created, executor resources: Map(cores -> name: cores, amount: 1, script: , vendor: , memory -> name: memory, amount: 1024, script: , vendor: , offHeap -> name: offHeap, amount: 0, script: , vendor: ), task resources: Map(cpus -> name: cpus, amount: 1.0)
15:57:26.368 [INFO - main] (Logging.scala:57) Limiting resource is cpu
15:57:26.369 [INFO - main] (Logging.scala:57) Added ResourceProfile id: 0
15:57:26.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.433048 10411 heartbeater.cc:503] Master 127.9.162.60:41659 was elected leader, sending a full tablet report...
15:57:26.501 [INFO - main] (Logging.scala:57) Changing view acls to: slave
15:57:26.502 [INFO - main] (Logging.scala:57) Changing modify acls to: slave
15:57:26.503 [INFO - main] (Logging.scala:57) Changing view acls groups to: 
15:57:26.503 [INFO - main] (Logging.scala:57) Changing modify acls groups to: 
15:57:26.504 [INFO - main] (Logging.scala:57) SecurityManager: authentication disabled; ui acls disabled; users  with view permissions: Set(slave); groups with view permissions: Set(); users  with modify permissions: Set(slave); groups with modify permissions: Set()
15:57:26.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.623595 10546 heartbeater.cc:503] Master 127.9.162.60:41659 was elected leader, sending a full tablet report...
15:57:26.863 [INFO - main] (Logging.scala:57) Successfully started service 'sparkDriver' on port 40749.
15:57:26.897 [INFO - main] (Logging.scala:57) Registering MapOutputTracker
15:57:26.934 [INFO - main] (Logging.scala:57) Registering BlockManagerMaster
15:57:26.960 [INFO - main] (Logging.scala:57) Using org.apache.spark.storage.DefaultTopologyMapper for getting topology information
15:57:26.961 [INFO - main] (Logging.scala:57) BlockManagerMasterEndpoint up
15:57:26.968 [INFO - main] (Logging.scala:57) Registering BlockManagerMasterHeartbeat
15:57:26.985 [INFO - main] (Logging.scala:57) Created local directory at /tmp/blockmgr-e4c38e3f-7adf-4814-9e12-8dc7b16da1f3
15:57:27.034 [INFO - main] (Logging.scala:57) MemoryStore started with capacity 1993.9 MiB
15:57:27.059 [INFO - main] (Logging.scala:57) Registering OutputCommitCoordinator
15:57:27.268 [INFO - main] (Logging.scala:57) Starting executor ID driver on host dist-test-slave-d6mh.c.gcp-upstream.internal
15:57:27.316 [INFO - main] (Logging.scala:57) Successfully started service 'org.apache.spark.network.netty.NettyBlockTransferService' on port 45609.
15:57:27.316 [INFO - main] (NettyBlockTransferService.scala:81) Server created on dist-test-slave-d6mh.c.gcp-upstream.internal:45609
15:57:27.320 [INFO - main] (Logging.scala:57) Using org.apache.spark.storage.RandomBlockReplicationPolicy for block replication policy
15:57:27.331 [INFO - main] (Logging.scala:57) Registering BlockManager BlockManagerId(driver, dist-test-slave-d6mh.c.gcp-upstream.internal, 45609, None)
15:57:27.336 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Registering block manager dist-test-slave-d6mh.c.gcp-upstream.internal:45609 with 1993.9 MiB RAM, BlockManagerId(driver, dist-test-slave-d6mh.c.gcp-upstream.internal, 45609, None)
15:57:27.340 [INFO - main] (Logging.scala:57) Registered BlockManager BlockManagerId(driver, dist-test-slave-d6mh.c.gcp-upstream.internal, 45609, None)
15:57:27.341 [INFO - main] (Logging.scala:57) Initialized BlockManager: BlockManagerId(driver, dist-test-slave-d6mh.c.gcp-upstream.internal, 45609, None)
15:57:27.577 [INFO - main] (Log.java:169) Logging initialized @5464ms to org.sparkproject.jetty.util.log.Slf4jLog
15:57:27.836 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
15:57:27.891 [DEBUG - main] (Connection.java:748) [peer master-127.9.162.62:38851(127.9.162.62:38851)] connecting to peer
15:57:27.897 [DEBUG - main] (DefaultChannelId.java:79) -Dio.netty.processId: 9851 (auto-detected)
15:57:27.899 [DEBUG - main] (NetUtil.java:148) -Djava.net.preferIPv4Stack: true
15:57:27.899 [DEBUG - main] (NetUtil.java:149) -Djava.net.preferIPv6Addresses: false
15:57:27.901 [DEBUG - main] (NetUtilInitializations.java:145) Loopback interface: lo (lo, 127.0.0.1)
15:57:27.902 [DEBUG - main] (NetUtil.java:188) /proc/sys/net/core/somaxconn: 4096
15:57:27.903 [DEBUG - main] (DefaultChannelId.java:101) -Dio.netty.machineId: 02:42:89:ff:fe:8f:18:91 (auto-detected)
15:57:27.928 [DEBUG - main] (ByteBufUtil.java:88) -Dio.netty.allocator.type: pooled
15:57:27.928 [DEBUG - main] (ByteBufUtil.java:97) -Dio.netty.threadLocalDirectBufferSize: 0
15:57:27.929 [DEBUG - main] (ByteBufUtil.java:100) -Dio.netty.maxThreadLocalCharBufferSize: 16384
15:57:27.939 [DEBUG - main] (Connection.java:748) [peer master-127.9.162.61:38117(127.9.162.61:38117)] connecting to peer
15:57:27.941 [DEBUG - main] (Connection.java:748) [peer master-127.9.162.60:41659(127.9.162.60:41659)] connecting to peer
15:57:27.970 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.9.162.61:38117(127.9.162.61:38117)] Successfully connected to peer
15:57:27.970 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.9.162.62:38851(127.9.162.62:38851)] Successfully connected to peer
15:57:27.983 [DEBUG - kudu-nio-1] (AbstractByteBuf.java:63) -Dorg.apache.kudu.shaded.io.netty.buffer.checkAccessible: true
15:57:27.983 [DEBUG - kudu-nio-1] (AbstractByteBuf.java:64) -Dorg.apache.kudu.shaded.io.netty.buffer.checkBounds: true
15:57:27.983 [DEBUG - kudu-nio-1] (ResourceLeakDetectorFactory.java:196) Loaded default ResourceLeakDetector: org.apache.kudu.shaded.io.netty.util.ResourceLeakDetector@7e42a8b1
15:57:27.989 [DEBUG - kudu-nio-1] (Recycler.java:96) -Dio.netty.recycler.maxCapacityPerThread: 4096
15:57:27.989 [DEBUG - kudu-nio-1] (Recycler.java:97) -Dio.netty.recycler.ratio: 8
15:57:27.989 [DEBUG - kudu-nio-1] (Recycler.java:98) -Dio.netty.recycler.chunkSize: 32
15:57:27.990 [DEBUG - kudu-nio-1] (Recycler.java:99) -Dio.netty.recycler.blocking: false
15:57:27.990 [DEBUG - kudu-nio-1] (Recycler.java:100) -Dio.netty.recycler.batchFastThreadLocalOnly: true
15:57:28.036 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.9.162.60:41659(127.9.162.60:41659)] Successfully connected to peer
15:57:28.057 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.9.162.61
15:57:28.057 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.9.162.62
15:57:28.164 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.9.162.60
15:57:28.258 [DEBUG - kudu-nio-1] (SslHandler.java:1842) [id: 0xembedded, L:embedded - R:embedded] HANDSHAKEN: protocol:TLSv1.2 cipher suite:TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256
15:57:28.271 [DEBUG - kudu-nio-0] (SslHandler.java:1842) [id: 0xembedded, L:embedded - R:embedded] HANDSHAKEN: protocol:TLSv1.2 cipher suite:TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256
15:57:28.274 [DEBUG - kudu-nio-0] (SslHandler.java:1842) [id: 0xembedded, L:embedded - R:embedded] HANDSHAKEN: protocol:TLSv1.2 cipher suite:TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256
15:57:28.277 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x32c53687, L:/127.0.0.1:46194 - R:/127.9.162.62:38851] using SASL/PLAIN
15:57:28.274 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x490d1e29, L:/127.0.0.1:59046 - R:/127.9.162.61:38117] using SASL/PLAIN
15:57:28.292 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x42d7e441, L:/127.0.0.1:34564 - R:/127.9.162.60:41659] using SASL/PLAIN
15:57:28.339 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.399104 10050 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:34564:
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "test"
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c1_i"
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c2_s"
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c3_double"
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DOUBLE
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c4_long"
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT64
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c5_bool"
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c6_short"
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT16
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c7_float"
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: FLOAT
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c8_binary"
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BINARY
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c9_unixtime_micros"
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: UNIXTIME_MICROS
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c10_byte"
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT8
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c11_decimal32"
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL32
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 9
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c12_decimal64"
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL64
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 18
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c13_decimal128"
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL128
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 38
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c14_varchar"
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: VARCHAR
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       length: 65535
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c15_date"
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DATE
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) split_rows_range_bounds {
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   rows: "<redacted>""\006\000\000\000\000\007\001\000\000\0002\000\000\000\006\001\000\000\0002\000\000\000\007\000\000\000\000"
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
15:57:28.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
15:57:28.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
15:57:28.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
15:57:28.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
15:57:28.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
15:57:28.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) owner: "testuser"
15:57:28.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.427337 10345 tablet_service.cc:1467] Processing CreateTablet for tablet 9c318fb0558f43da8271c8e321aa3e77 (DEFAULT_TABLE table=test [id=f04949ae3e4245d9926b4b052aec5eca]), partition=RANGE (key) PARTITION VALUES < 50
15:57:28.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.429226 10345 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 9c318fb0558f43da8271c8e321aa3e77. 1 dirs total, 0 dirs full, 0 dirs failed
15:57:28.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.430131 10210 tablet_service.cc:1467] Processing CreateTablet for tablet a68d09d6c7024a7f8ca11d4ef280ed36 (DEFAULT_TABLE table=test [id=f04949ae3e4245d9926b4b052aec5eca]), partition=RANGE (key) PARTITION 50 <= VALUES
15:57:28.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.431866 10210 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet a68d09d6c7024a7f8ca11d4ef280ed36. 1 dirs total, 0 dirs full, 0 dirs failed
15:57:28.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.439589 10609 tablet_bootstrap.cc:492] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5: Bootstrap starting.
15:57:28.440 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table f04949ae3e4245d9926b4b052aec5eca
15:57:28.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.440645 10608 tablet_bootstrap.cc:492] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740: Bootstrap starting.
15:57:28.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.442368 10609 tablet_bootstrap.cc:654] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5: Neither blocks nor log segments found. Creating new log.
15:57:28.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.443190 10608 tablet_bootstrap.cc:654] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740: Neither blocks nor log segments found. Creating new log.
15:57:28.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.443825 10609 log.cc:824] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5: Log is configured to *not* fsync() on all Append() calls
15:57:28.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.444504 10608 log.cc:824] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740: Log is configured to *not* fsync() on all Append() calls
15:57:28.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.445999 10609 tablet_bootstrap.cc:492] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5: No bootstrap required, opened a new log
15:57:28.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.446223 10609 ts_tablet_manager.cc:1397] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5: Time spent bootstrapping tablet: real 0.007s	user 0.005s	sys 0.000s
15:57:28.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.446424 10608 tablet_bootstrap.cc:492] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740: No bootstrap required, opened a new log
15:57:28.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.446614 10608 ts_tablet_manager.cc:1397] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740: Time spent bootstrapping tablet: real 0.006s	user 0.000s	sys 0.004s
15:57:28.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.450662 10608 raft_consensus.cc:348] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "88b5f97aa23b4ceca45a4a7501aec740" member_type: VOTER last_known_addr { host: "127.9.162.2" port: 41957 } }
15:57:28.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.450858 10609 raft_consensus.cc:348] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "f4550fe7ed2a4afa9de03f12a21431b5" member_type: VOTER last_known_addr { host: "127.9.162.1" port: 46165 } }
15:57:28.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.451066 10609 raft_consensus.cc:374] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:28.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.451114 10609 raft_consensus.cc:729] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f4550fe7ed2a4afa9de03f12a21431b5, State: Initialized, Role: FOLLOWER
15:57:28.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.451692 10609 consensus_queue.cc:260] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "f4550fe7ed2a4afa9de03f12a21431b5" member_type: VOTER last_known_addr { host: "127.9.162.1" port: 46165 } }
15:57:28.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.451906 10609 raft_consensus.cc:388] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
15:57:28.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.451977 10609 raft_consensus.cc:482] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
15:57:28.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.452081 10609 raft_consensus.cc:3037] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [term 0 FOLLOWER]: Advancing to term 1
15:57:28.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.453306 10609 raft_consensus.cc:504] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "f4550fe7ed2a4afa9de03f12a21431b5" member_type: VOTER last_known_addr { host: "127.9.162.1" port: 46165 } }
15:57:28.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.453747 10609 leader_election.cc:302] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: f4550fe7ed2a4afa9de03f12a21431b5; no voters: 
15:57:28.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.454156 10609 leader_election.cc:288] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [CANDIDATE]: Term 1 election: Requested vote from peers 
15:57:28.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.454281 10612 raft_consensus.cc:2781] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [term 1 FOLLOWER]: Leader election won for term 1
15:57:28.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.454743 10612 raft_consensus.cc:686] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [term 1 LEADER]: Becoming Leader. State: Replica: f4550fe7ed2a4afa9de03f12a21431b5, State: Running, Role: LEADER
15:57:28.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.455224 10612 consensus_queue.cc:237] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "f4550fe7ed2a4afa9de03f12a21431b5" member_type: VOTER last_known_addr { host: "127.9.162.1" port: 46165 } }
15:57:28.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.455688 10609 ts_tablet_manager.cc:1428] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5: Time spent starting tablet: real 0.009s	user 0.007s	sys 0.004s
15:57:28.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.460613 10608 raft_consensus.cc:374] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:28.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.460592 10050 catalog_manager.cc:5495] T a68d09d6c7024a7f8ca11d4ef280ed36 P f4550fe7ed2a4afa9de03f12a21431b5 reported cstate change: term changed from 0 to 1, leader changed from <none> to f4550fe7ed2a4afa9de03f12a21431b5 (127.9.162.1). New cstate: current_term: 1 leader_uuid: "f4550fe7ed2a4afa9de03f12a21431b5" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "f4550fe7ed2a4afa9de03f12a21431b5" member_type: VOTER last_known_addr { host: "127.9.162.1" port: 46165 } health_report { overall_health: HEALTHY } } }
15:57:28.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.460925 10608 raft_consensus.cc:729] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 88b5f97aa23b4ceca45a4a7501aec740, State: Initialized, Role: FOLLOWER
15:57:28.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.461546 10608 consensus_queue.cc:260] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "88b5f97aa23b4ceca45a4a7501aec740" member_type: VOTER last_known_addr { host: "127.9.162.2" port: 41957 } }
15:57:28.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.461760 10608 raft_consensus.cc:388] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
15:57:28.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.461864 10608 raft_consensus.cc:482] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
15:57:28.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.461985 10608 raft_consensus.cc:3037] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [term 0 FOLLOWER]: Advancing to term 1
15:57:28.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.463435 10608 raft_consensus.cc:504] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "88b5f97aa23b4ceca45a4a7501aec740" member_type: VOTER last_known_addr { host: "127.9.162.2" port: 41957 } }
15:57:28.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.464107 10608 leader_election.cc:302] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: 88b5f97aa23b4ceca45a4a7501aec740; no voters: 
15:57:28.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.464664 10608 leader_election.cc:288] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [CANDIDATE]: Term 1 election: Requested vote from peers 
15:57:28.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.464758 10617 raft_consensus.cc:2781] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [term 1 FOLLOWER]: Leader election won for term 1
15:57:28.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.465157 10617 raft_consensus.cc:686] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [term 1 LEADER]: Becoming Leader. State: Replica: 88b5f97aa23b4ceca45a4a7501aec740, State: Running, Role: LEADER
15:57:28.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.465667 10617 consensus_queue.cc:237] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "88b5f97aa23b4ceca45a4a7501aec740" member_type: VOTER last_known_addr { host: "127.9.162.2" port: 41957 } }
15:57:28.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.465937 10608 ts_tablet_manager.cc:1428] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740: Time spent starting tablet: real 0.019s	user 0.008s	sys 0.002s
15:57:28.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.471400 10050 catalog_manager.cc:5495] T 9c318fb0558f43da8271c8e321aa3e77 P 88b5f97aa23b4ceca45a4a7501aec740 reported cstate change: term changed from 0 to 1, leader changed from <none> to 88b5f97aa23b4ceca45a4a7501aec740 (127.9.162.2). New cstate: current_term: 1 leader_uuid: "88b5f97aa23b4ceca45a4a7501aec740" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "88b5f97aa23b4ceca45a4a7501aec740" member_type: VOTER last_known_addr { host: "127.9.162.2" port: 41957 } health_report { overall_health: HEALTHY } } }
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.496728 10050 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:34564:
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "simple-test"
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "val"
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
15:57:28.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:57:28.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
15:57:28.511 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 9e35217c2e024eee8f85e6f2ecb11f89
15:57:28.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.517037 10480 tablet_service.cc:1467] Processing CreateTablet for tablet 4ee95f55110545129ad0430302ea4dd3 (DEFAULT_TABLE table=simple-test [id=9e35217c2e024eee8f85e6f2ecb11f89]), partition=RANGE (key) PARTITION UNBOUNDED
15:57:28.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.518110 10480 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 4ee95f55110545129ad0430302ea4dd3. 1 dirs total, 0 dirs full, 0 dirs failed
15:57:28.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.524024 10623 tablet_bootstrap.cc:492] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62: Bootstrap starting.
15:57:28.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.526163 10623 tablet_bootstrap.cc:654] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62: Neither blocks nor log segments found. Creating new log.
15:57:28.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.526873 10623 log.cc:824] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62: Log is configured to *not* fsync() on all Append() calls
15:57:28.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.528721 10623 tablet_bootstrap.cc:492] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62: No bootstrap required, opened a new log
15:57:28.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.528905 10623 ts_tablet_manager.cc:1397] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62: Time spent bootstrapping tablet: real 0.005s	user 0.003s	sys 0.000s
15:57:28.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.532413 10623 raft_consensus.cc:348] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c5ae16a14ae647a6a45fba7c6af37b62" member_type: VOTER last_known_addr { host: "127.9.162.3" port: 44675 } }
15:57:28.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.532974 10623 raft_consensus.cc:374] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:28.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.533198 10623 raft_consensus.cc:729] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c5ae16a14ae647a6a45fba7c6af37b62, State: Initialized, Role: FOLLOWER
15:57:28.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.533854 10623 consensus_queue.cc:260] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c5ae16a14ae647a6a45fba7c6af37b62" member_type: VOTER last_known_addr { host: "127.9.162.3" port: 44675 } }
15:57:28.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.534072 10623 raft_consensus.cc:388] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
15:57:28.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.534147 10623 raft_consensus.cc:482] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
15:57:28.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.534271 10623 raft_consensus.cc:3037] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [term 0 FOLLOWER]: Advancing to term 1
15:57:28.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.535457 10623 raft_consensus.cc:504] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c5ae16a14ae647a6a45fba7c6af37b62" member_type: VOTER last_known_addr { host: "127.9.162.3" port: 44675 } }
15:57:28.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.535902 10623 leader_election.cc:302] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: c5ae16a14ae647a6a45fba7c6af37b62; no voters: 
15:57:28.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.536290 10623 leader_election.cc:288] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [CANDIDATE]: Term 1 election: Requested vote from peers 
15:57:28.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.536362 10625 raft_consensus.cc:2781] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [term 1 FOLLOWER]: Leader election won for term 1
15:57:28.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.536561 10625 raft_consensus.cc:686] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [term 1 LEADER]: Becoming Leader. State: Replica: c5ae16a14ae647a6a45fba7c6af37b62, State: Running, Role: LEADER
15:57:28.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.536882 10625 consensus_queue.cc:237] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c5ae16a14ae647a6a45fba7c6af37b62" member_type: VOTER last_known_addr { host: "127.9.162.3" port: 44675 } }
15:57:28.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.537400 10623 ts_tablet_manager.cc:1428] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62: Time spent starting tablet: real 0.008s	user 0.005s	sys 0.003s
15:57:28.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:28.540220 10050 catalog_manager.cc:5495] T 4ee95f55110545129ad0430302ea4dd3 P c5ae16a14ae647a6a45fba7c6af37b62 reported cstate change: term changed from 0 to 1, leader changed from <none> to c5ae16a14ae647a6a45fba7c6af37b62 (127.9.162.3). New cstate: current_term: 1 leader_uuid: "c5ae16a14ae647a6a45fba7c6af37b62" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c5ae16a14ae647a6a45fba7c6af37b62" member_type: VOTER last_known_addr { host: "127.9.162.3" port: 44675 } health_report { overall_health: HEALTHY } } }
15:57:30.252 [INFO - main] (Logging.scala:57) Setting hive.metastore.warehouse.dir ('null') to the value of spark.sql.warehouse.dir ('file:/tmp/dist-test-taskmdTBqi/java/build/dist-test/spark-warehouse').
15:57:30.253 [INFO - main] (Logging.scala:57) Warehouse path is 'file:/tmp/dist-test-taskmdTBqi/java/build/dist-test/spark-warehouse'.
15:57:31.657 [INFO - main] (Logging.scala:57) Registered StateStoreCoordinator endpoint
log4j:WARN No appenders could be found for logger (org.apache.htrace.core.Tracer).
log4j:WARN Please initialize the log4j system properly.
log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
15:57:31.769 [INFO - main] (Logging.scala:57) Checkpoint root /tmp/spark_kudu2766798666654254752 resolved to file:/tmp/spark_kudu2766798666654254752.
15:57:31.833 [INFO - main] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu2766798666654254752/metadata using temp file file:/tmp/spark_kudu2766798666654254752/.metadata.d7fb7af4-ff32-40b2-a858-cedeb3cb6875.tmp
15:57:31.942 [INFO - main] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu2766798666654254752/.metadata.d7fb7af4-ff32-40b2-a858-cedeb3cb6875.tmp to file:/tmp/spark_kudu2766798666654254752/metadata
15:57:31.980 [INFO - main] (Logging.scala:57) Starting [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]. Use file:/tmp/spark_kudu2766798666654254752 to store the query checkpoint.
15:57:31.994 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Reading table [org.apache.spark.sql.execution.streaming.MemoryStreamTable@76ef3043] from DataSourceV2 named 'memory' [org.apache.spark.sql.execution.streaming.MemoryStreamTableProvider$@77667fb2]
15:57:32.004 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Starting new streaming query.
15:57:32.008 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Stream started from {}
15:57:32.082 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Streaming query made progress: {
  "id" : "efa1157a-9c8c-4808-a6c3-f995b2ceae06",
  "runId" : "0a12495f-a78c-436d-bc92-21c54aed1f19",
  "name" : null,
  "timestamp" : "2026-07-08T15:57:32.002Z",
  "batchId" : 0,
  "numInputRows" : 0,
  "inputRowsPerSecond" : 0.0,
  "processedRowsPerSecond" : 0.0,
  "durationMs" : {
    "latestOffset" : 0,
    "triggerExecution" : 16
  },
  "stateOperators" : [ ],
  "sources" : [ {
    "description" : "MemoryStream[value#1]",
    "startOffset" : null,
    "endOffset" : null,
    "numInputRows" : 0,
    "inputRowsPerSecond" : 0.0,
    "processedRowsPerSecond" : 0.0
  } ],
  "sink" : {
    "description" : "org.apache.kudu.spark.kudu.KuduSink@1ec99b4e",
    "numOutputRows" : -1
  }
}
15:57:32.334 [INFO - main] (Logging.scala:57) Code generated in 226.324441 ms
15:57:32.355 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu2766798666654254752/offsets/0 using temp file file:/tmp/spark_kudu2766798666654254752/offsets/.0.c3c21a07-d922-4fe4-9146-1cd66d578418.tmp
15:57:32.388 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu2766798666654254752/offsets/.0.c3c21a07-d922-4fe4-9146-1cd66d578418.tmp to file:/tmp/spark_kudu2766798666654254752/offsets/0
15:57:32.389 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Committed offsets for batch 0. Metadata OffsetSeqMetadata(0,1783526252340,Map(spark.sql.streaming.stateStore.providerClass -> org.apache.spark.sql.execution.streaming.state.HDFSBackedStateStoreProvider, spark.sql.streaming.join.stateFormatVersion -> 2, spark.sql.streaming.stateStore.compression.codec -> lz4, spark.sql.streaming.flatMapGroupsWithState.stateFormatVersion -> 2, spark.sql.streaming.multipleWatermarkPolicy -> min, spark.sql.streaming.aggregation.stateFormatVersion -> 2, spark.sql.shuffle.partitions -> 200))
15:57:33.435 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Code generated in 40.320956 ms
15:57:33.673 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Starting job: start at StreamingTest.scala:54
15:57:33.697 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Got job 0 (start at StreamingTest.scala:54) with 1 output partitions
15:57:33.697 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Final stage: ResultStage 0 (start at StreamingTest.scala:54)
15:57:33.698 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Parents of final stage: List()
15:57:33.700 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Missing parents: List()
15:57:33.708 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting ResultStage 0 (MapPartitionsRDD[4] at start at StreamingTest.scala:54), which has no missing parents
15:57:33.808 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Block broadcast_0 stored as values in memory (estimated size 17.1 KiB, free 1993.9 MiB)
15:57:33.856 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Block broadcast_0_piece0 stored as bytes in memory (estimated size 7.8 KiB, free 1993.9 MiB)
15:57:33.860 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Added broadcast_0_piece0 in memory on dist-test-slave-d6mh.c.gcp-upstream.internal:45609 (size: 7.8 KiB, free: 1993.9 MiB)
15:57:33.864 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Created broadcast 0 from broadcast at DAGScheduler.scala:1388
15:57:33.882 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting 1 missing tasks from ResultStage 0 (MapPartitionsRDD[4] at start at StreamingTest.scala:54) (first 15 tasks are for partitions Vector(0))
15:57:33.883 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Adding task set 0.0 with 1 tasks resource profile 0
15:57:33.949 [INFO - dispatcher-event-loop-1] (Logging.scala:57) Starting task 0.0 in stage 0.0 (TID 0) (dist-test-slave-d6mh.c.gcp-upstream.internal, executor driver, partition 0, PROCESS_LOCAL, 4803 bytes) taskResourceAssignments Map()
15:57:33.968 [INFO - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (Logging.scala:57) Running task 0.0 in stage 0.0 (TID 0)
15:57:34.402 [DEBUG - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (SecurityContext.java:320) Importing authentication credentials with one authn token, with no JWT, 1 cert(s), and realUser=slave
15:57:34.407 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 9e35217c2e024eee8f85e6f2ecb11f89
15:57:34.413 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 9e35217c2e024eee8f85e6f2ecb11f89
15:57:34.421 [INFO - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (KuduContext.scala:515) applying operations of type 'upsert' to table 'simple-test'
15:57:34.438 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 4ee95f55110545129ad0430302ea4dd3 for table 'simple-test' with partition [<start>, <end>)
15:57:34.440 [DEBUG - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=3, operationSize=114, flusherTask=org.apache.kudu.client.AsyncKuduSession$FlusherTask@63dfb248, flushNotification=Deferred@2053351034(state=PENDING, result=null, callback=<none>, errback=<none>)}
15:57:34.438 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299990, tablet=4ee95f55110545129ad0430302ea4dd3@[c5ae16a14ae647a6a45fba7c6af37b62(127.9.162.3:44675)[L]]}]
15:57:34.453 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 4ee95f55110545129ad0430302ea4dd3 for table 'simple-test' with partition [<start>, <end>)
15:57:34.454 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=4ee95f55110545129ad0430302ea4dd3@[c5ae16a14ae647a6a45fba7c6af37b62(127.9.162.3:44675)[L]]}]
15:57:34.455 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 4ee95f55110545129ad0430302ea4dd3 for table 'simple-test' with partition [<start>, <end>)
15:57:34.456 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=4ee95f55110545129ad0430302ea4dd3@[c5ae16a14ae647a6a45fba7c6af37b62(127.9.162.3:44675)[L]]}]
15:57:34.466 [DEBUG - kudu-nio-0] (Connection.java:748) [peer c5ae16a14ae647a6a45fba7c6af37b62(127.9.162.3:44675)] connecting to peer
15:57:34.469 [DEBUG - kudu-nio-1] (Connection.java:757) [peer c5ae16a14ae647a6a45fba7c6af37b62(127.9.162.3:44675)] Successfully connected to peer
15:57:34.505 [DEBUG - kudu-nio-1] (SslHandler.java:1842) [id: 0xembedded, L:embedded - R:embedded] HANDSHAKEN: protocol:TLSv1.2 cipher suite:TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256
15:57:34.508 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x215ede8e, L:/127.0.0.1:44920 - R:/127.9.162.3:44675] using TOKEN/null
15:57:34.543 [INFO - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (KuduContext.scala:536) applied 3 upserts to table 'simple-test' in 117ms
15:57:34.568 [INFO - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (Logging.scala:57) Finished task 0.0 in stage 0.0 (TID 0). 6753 bytes result sent to driver
15:57:34.582 [INFO - task-result-getter-0] (Logging.scala:57) Finished task 0.0 in stage 0.0 (TID 0) in 645 ms on dist-test-slave-d6mh.c.gcp-upstream.internal (executor driver) (1/1)
15:57:34.585 [INFO - task-result-getter-0] (Logging.scala:57) Removed TaskSet 0.0, whose tasks have all completed, from pool 
15:57:34.595 [INFO - dag-scheduler-event-loop] (Logging.scala:57) ResultStage 0 (start at StreamingTest.scala:54) finished in 0.868 s
15:57:34.600 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Job 0 is finished. Cancelling potential speculative or zombie tasks for this job
15:57:34.619 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Killing all running tasks in stage 0: Stage finished
15:57:34.622 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Job 0 finished: start at StreamingTest.scala:54, took 0.949009 s
15:57:34.626 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (KuduContext.scala:445) completed upsert ops: duration histogram: 117ms
15:57:34.645 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu2766798666654254752/commits/0 using temp file file:/tmp/spark_kudu2766798666654254752/commits/.0.1fe2c2be-26a6-4b57-99aa-b9c3e65aa5a1.tmp
15:57:34.668 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu2766798666654254752/commits/.0.1fe2c2be-26a6-4b57-99aa-b9c3e65aa5a1.tmp to file:/tmp/spark_kudu2766798666654254752/commits/0
15:57:34.687 [INFO - stream execution thread for [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19]] (Logging.scala:57) Streaming query made progress: {
  "id" : "efa1157a-9c8c-4808-a6c3-f995b2ceae06",
  "runId" : "0a12495f-a78c-436d-bc92-21c54aed1f19",
  "name" : null,
  "timestamp" : "2026-07-08T15:57:32.339Z",
  "batchId" : 0,
  "numInputRows" : 3,
  "inputRowsPerSecond" : 272.72727272727275,
  "processedRowsPerSecond" : 1.287001287001287,
  "durationMs" : {
    "addBatch" : 1646,
    "getBatch" : 3,
    "latestOffset" : 0,
    "queryPlanning" : 585,
    "triggerExecution" : 2331,
    "walCommit" : 48
  },
  "stateOperators" : [ ],
  "sources" : [ {
    "description" : "MemoryStream[value#1]",
    "startOffset" : null,
    "endOffset" : 0,
    "numInputRows" : 3,
    "inputRowsPerSecond" : 272.72727272727275,
    "processedRowsPerSecond" : 1.287001287001287
  } ],
  "sink" : {
    "description" : "org.apache.kudu.spark.kudu.KuduSink@1ec99b4e",
    "numOutputRows" : -1
  }
}
15:57:34.704 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 9e35217c2e024eee8f85e6f2ecb11f89
15:57:34.817 [INFO - main] (Logging.scala:57) Code generated in 16.23476 ms
15:57:34.922 [INFO - main] (Logging.scala:57) Starting job: collect at StreamingTest.scala:60
15:57:34.923 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Got job 1 (collect at StreamingTest.scala:60) with 1 output partitions
15:57:34.923 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Final stage: ResultStage 1 (collect at StreamingTest.scala:60)
15:57:34.923 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Parents of final stage: List()
15:57:34.924 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Missing parents: List()
15:57:34.926 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting ResultStage 1 (MapPartitionsRDD[11] at map at StreamingTest.scala:60), which has no missing parents
15:57:34.934 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Block broadcast_1 stored as values in memory (estimated size 18.6 KiB, free 1993.8 MiB)
15:57:34.937 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Block broadcast_1_piece0 stored as bytes in memory (estimated size 9.1 KiB, free 1993.8 MiB)
15:57:34.938 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Added broadcast_1_piece0 in memory on dist-test-slave-d6mh.c.gcp-upstream.internal:45609 (size: 9.1 KiB, free: 1993.9 MiB)
15:57:34.938 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Created broadcast 1 from broadcast at DAGScheduler.scala:1388
15:57:34.939 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting 1 missing tasks from ResultStage 1 (MapPartitionsRDD[11] at map at StreamingTest.scala:60) (first 15 tasks are for partitions Vector(0))
15:57:34.940 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Adding task set 1.0 with 1 tasks resource profile 0
15:57:34.946 [INFO - dispatcher-event-loop-0] (Logging.scala:57) Starting task 0.0 in stage 1.0 (TID 1) (dist-test-slave-d6mh.c.gcp-upstream.internal, executor driver, partition 0, ANY, 4794 bytes) taskResourceAssignments Map()
15:57:34.946 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Running task 0.0 in stage 1.0 (TID 1)
15:57:35.072 [DEBUG - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (SecurityContext.java:320) Importing authentication credentials with one authn token, with no JWT, 1 cert(s), and realUser=slave
15:57:35.113 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Code generated in 13.70217 ms
15:57:35.153 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305323541039968256) for scanner KuduScanner(table=simple-test, tablet=4ee95f55110545129ad0430302ea4dd3, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
15:57:35.203 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Code generated in 33.495046 ms
15:57:35.207 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Finished task 0.0 in stage 1.0 (TID 1). 5370 bytes result sent to driver
15:57:35.212 [INFO - task-result-getter-1] (Logging.scala:57) Finished task 0.0 in stage 1.0 (TID 1) in 268 ms on dist-test-slave-d6mh.c.gcp-upstream.internal (executor driver) (1/1)
15:57:35.212 [INFO - task-result-getter-1] (Logging.scala:57) Removed TaskSet 1.0, whose tasks have all completed, from pool 
15:57:35.213 [INFO - dag-scheduler-event-loop] (Logging.scala:57) ResultStage 1 (collect at StreamingTest.scala:60) finished in 0.283 s
15:57:35.214 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Job 1 is finished. Cancelling potential speculative or zombie tasks for this job
15:57:35.214 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Killing all running tasks in stage 1: Stage finished
15:57:35.214 [INFO - main] (Logging.scala:57) Job 1 finished: collect at StreamingTest.scala:60, took 0.292249 s
15:57:35.218 [INFO - main] (Logging.scala:57) Asked to cancel job group 0a12495f-a78c-436d-bc92-21c54aed1f19
15:57:35.254 [INFO - main] (Logging.scala:57) Asked to cancel job group 0a12495f-a78c-436d-bc92-21c54aed1f19
15:57:35.255 [INFO - main] (Logging.scala:57) Query [id = efa1157a-9c8c-4808-a6c3-f995b2ceae06, runId = 0a12495f-a78c-436d-bc92-21c54aed1f19] was stopped
15:57:35.281 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Removed broadcast_1_piece0 on dist-test-slave-d6mh.c.gcp-upstream.internal:45609 in memory (size: 9.1 KiB, free: 1993.9 MiB)
15:57:35.309 [INFO - dispatcher-event-loop-0] (Logging.scala:57) MapOutputTrackerMasterEndpoint stopped!
15:57:35.324 [INFO - main] (Logging.scala:57) MemoryStore cleared
15:57:35.324 [INFO - main] (Logging.scala:57) BlockManager stopped
15:57:35.330 [INFO - main] (Logging.scala:57) BlockManagerMaster stopped
15:57:35.333 [INFO - dispatcher-event-loop-0] (Logging.scala:57) OutputCommitCoordinator stopped!
15:57:35.341 [INFO - main] (Logging.scala:57) Successfully stopped SparkContext
15:57:35.345 [DEBUG - main] (Connection.java:575) [peer master-127.9.162.61:38117(127.9.162.61:38117)] disconnecting while in state READY
15:57:35.348 [DEBUG - main] (Connection.java:575) [peer master-127.9.162.62:38851(127.9.162.62:38851)] disconnecting while in state READY
15:57:35.349 [DEBUG - main] (Connection.java:575) [peer c5ae16a14ae647a6a45fba7c6af37b62(127.9.162.3:44675)] disconnecting while in state READY
15:57:35.349 [DEBUG - main] (Connection.java:575) [peer master-127.9.162.60:41659(127.9.162.60:41659)] disconnecting while in state READY
15:57:35.355 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2704) Releasing all remaining resources
15:57:35.357 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.9.162.62:38851(127.9.162.62:38851)] handling channelInactive
15:57:35.357 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.9.162.62:38851(127.9.162.62:38851)] cleaning up while in state READY due to: connection closed
15:57:35.358 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.9.162.60:41659(127.9.162.60:41659)] handling channelInactive
15:57:35.358 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.9.162.60:41659(127.9.162.60:41659)] cleaning up while in state READY due to: connection closed
15:57:35.358 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.9.162.61:38117(127.9.162.61:38117)] handling channelInactive
15:57:35.358 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.9.162.61:38117(127.9.162.61:38117)] cleaning up while in state READY due to: connection closed
15:57:35.359 [DEBUG - kudu-nio-1] (Connection.java:239) [peer c5ae16a14ae647a6a45fba7c6af37b62(127.9.162.3:44675)] handling channelInactive
15:57:35.359 [DEBUG - kudu-nio-1] (Connection.java:709) [peer c5ae16a14ae647a6a45fba7c6af37b62(127.9.162.3:44675)] cleaning up while in state READY due to: connection closed
15:57:35.361 [DEBUG - kudu-nio-0] (PoolThreadCache.java:221) Freed 32 thread-local buffer(s) from thread: kudu-nio-0
15:57:35.361 [DEBUG - kudu-nio-1] (PoolThreadCache.java:221) Freed 22 thread-local buffer(s) from thread: kudu-nio-1
15:57:35.370 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
15:57:35.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:35.371429  9864 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu with pid 10148
15:57:35.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:35.376435  9864 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu with pid 10283
15:57:35.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:35.382527  9864 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu with pid 10418
15:57:35.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:35.388603  9864 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu with pid 9875
15:57:35.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:35.393782  9864 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu with pid 9944
15:57:35.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:35.400302  9864 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskmdTBqi/build/debug/bin/kudu with pid 10016
15:57:35.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T15:57:35Z chronyd exiting

Time: 13.181

OK (1 test)

15:57:35.676 [INFO - shutdown-hook-0] (Logging.scala:57) Shutdown hook called
15:57:35.677 [INFO - shutdown-hook-0] (Logging.scala:57) Deleting directory /tmp/spark-4cd291b6-b854-4223-a064-334776820845
