JUnit version 4.13.2
.SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in [jar:file:/tmp/dist-test-taskOhPADJ/java/build/jars/log4j-slf4j-impl-2.17.1.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: Found binding in [jar:file:/tmp/dist-test-taskOhPADJ/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]
23:59:09.494 [INFO - main] (RandomUtils.java:49) Using random seed: 1783468749491
23:59:09.523 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
23:59:09.588 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
23:59:09.596 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskOhPADJ/test-tmp
23:59:09.599 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/asan/bin
23:59:09.601 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskOhPADJ/java/build/dist-test/../../../build/asan/bin/kudu, test, mini_cluster, --serialization=pb]
23:59:09.632 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

23:59:09.963 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
23:59:09.970 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

23:59:09.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:09.973336 29343 mini_oidc.cc:152] Starting JWKS server
23:59:09.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:09.976135 29343 webserver.cc:460] Webserver started at http://127.0.0.1:39117/ using document root <none> and password file <none>
23:59:09.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:09.976362 29343 mini_oidc.cc:189] Starting OIDC Discovery server
23:59:09.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:09.976902 29343 webserver.cc:460] Webserver started at http://127.0.0.1:38545/ using document root <none> and password file <none>
23:59:09.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:59:09Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
23:59:09.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:59:09Z Disabled control of system clock
23:59:10.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.006786 29343 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:10.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:10.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/wal
23:59:10.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/data
23:59:10.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:59:10.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:59:10.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:59:10.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:10.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:10.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:10.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/logs
23:59:10.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/data/info.pb
23:59:10.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:10.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:59:10.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:59:10.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:59:10.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:59:10.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:10.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:10.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:10.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
23:59:10.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:59:10.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:59:10.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:59:10.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.254:33339
23:59:10.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.254
23:59:10.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:10.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:10.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:10.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:10.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:59:10.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:59:10.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:10.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:59:10.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39117/jwks.json with env {}
23:59:10.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.353909 29354 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
23:59:10.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.354208 29354 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:59:10.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.354302 29354 flags.cc:425] Enabled unsafe flag: --never_fsync=true
23:59:10.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.361690 29354 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
23:59:10.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.361804 29354 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
23:59:10.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.361847 29354 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
23:59:10.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.361931 29354 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
23:59:10.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.361996 29354 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
23:59:10.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.362051 29354 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:39117/jwks.json
23:59:10.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.371490 29354 master_runner.cc:386] Master server non-default flags:
23:59:10.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:10.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:10.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:10.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:59:10.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/data
23:59:10.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/wal
23:59:10.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:59:10.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:10.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:10.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:10.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:59:10.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.254:33339
23:59:10.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:59:10.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:59:10.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:59:10.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39117/jwks.json
23:59:10.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:10.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:10.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/data/info.pb
23:59:10.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.254
23:59:10.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:10.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:59:10.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:10.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:59:10.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:59:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/logs
23:59:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:59:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:59:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
23:59:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
23:59:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
23:59:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
23:59:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 22:40:22 UTC on ccycloud.quasar-znwdty.root.comops.site
23:59:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492328
23:59:10.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
23:59:10.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.373064 29354 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:59:10.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.375089 29354 file_cache.cc:493] Constructed file cache file cache with capacity 419430
23:59:10.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.387629 29359 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
23:59:10.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.387562 29362 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
23:59:10.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.387578 29360 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
23:59:10.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.387915 29354 server_base.cc:1034] running on GCE node
23:59:10.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.389739 29354 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:59:10.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.391198 29354 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:59:10.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.392427 29354 hybrid_clock.cc:648] HybridClock initialized: now 1783468750392346 us; error 64 us; skew 500 ppm
23:59:10.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.392735 29354 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
23:59:10.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.395237 29354 webserver.cc:460] Webserver started at http://127.28.167.254:44801/ using document root <none> and password file <none>
23:59:10.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.395990 29354 fs_manager.cc:359] Metadata directory not provided
23:59:10.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.396093 29354 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:59:10.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.396355 29354 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
23:59:10.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.399046 29354 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/data/instance:
23:59:10.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b37b50cb30804e45ad834c217af35f09"
23:59:10.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:10 on dist-test-slave-5n60"
23:59:10.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.399845 29354 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/wal/instance:
23:59:10.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b37b50cb30804e45ad834c217af35f09"
23:59:10.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:10 on dist-test-slave-5n60"
23:59:10.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.405575 29354 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.007s	sys 0.000s
23:59:10.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.409046 29368 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:59:10.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.410611 29354 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
23:59:10.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.410765 29354 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/data,/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/wal
23:59:10.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b37b50cb30804e45ad834c217af35f09"
23:59:10.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:10 on dist-test-slave-5n60"
23:59:10.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.411002 29354 fs_report.cc:383] FS layout report
23:59:10.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:59:10.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/wal
23:59:10.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/wal
23:59:10.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/data/data
23:59:10.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:59:10.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:59:10.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:59:10.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:59:10.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:59:10.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:59:10.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:59:10.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:59:10.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:59:10.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:59:10.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:59:10.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.441885 29354 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
23:59:10.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.442747 29354 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
23:59:10.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.443032 29354 kserver.cc:163] Server-wide thread pool size limit: 3276
23:59:10.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.462154 29354 rpc_server.cc:307] RPC server started. Bound to: 127.28.167.254:33339
23:59:10.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.462236 29419 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.28.167.254:33339 every 8 connection(s)
23:59:10.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.463722 29354 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/data/info.pb
23:59:10.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.467465 29343 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu as pid 29354
23:59:10.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.467675 29343 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-0/wal/instance
23:59:10.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.467758 29420 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
23:59:10.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.470000 29343 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:10.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:10.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/wal
23:59:10.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/data
23:59:10.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:59:10.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:59:10.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:59:10.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:10.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/logs
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/data/info.pb
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
23:59:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:59:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:59:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:59:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.253:45159
23:59:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.253
23:59:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:59:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:59:10.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:10.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:59:10.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39117/jwks.json with env {}
23:59:10.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.476125 29420 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } has no permanent_uuid. Determining permanent_uuid...
23:59:10.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.496490 29420 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } has no permanent_uuid. Determining permanent_uuid...
23:59:10.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.497817 29370 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.28.167.253:45159: connect: Connection refused (error 111)
23:59:10.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.499466 29420 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.253:45159: Network error: Client connection negotiation failed: client connection to 127.28.167.253:45159: connect: Connection refused (error 111)
23:59:10.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.548847 29420 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } attempt: 1
23:59:10.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.551115 29420 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.253:45159: Network error: Client connection negotiation failed: client connection to 127.28.167.253:45159: connect: Connection refused (error 111)
23:59:10.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.619407 29420 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } attempt: 2
23:59:10.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.621562 29420 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.253:45159: Network error: Client connection negotiation failed: client connection to 127.28.167.253:45159: connect: Connection refused (error 111)
23:59:10.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.712884 29420 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } attempt: 3
23:59:10.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.714995 29420 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.253:45159: Network error: Client connection negotiation failed: client connection to 127.28.167.253:45159: connect: Connection refused (error 111)
23:59:10.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.800740 29422 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
23:59:10.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.801060 29422 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:59:10.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.801147 29422 flags.cc:425] Enabled unsafe flag: --never_fsync=true
23:59:10.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.808655 29422 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
23:59:10.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.808758 29422 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
23:59:10.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.808806 29422 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
23:59:10.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.808856 29422 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
23:59:10.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.808893 29422 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
23:59:10.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.808941 29422 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:39117/jwks.json
23:59:10.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.818564 29422 master_runner.cc:386] Master server non-default flags:
23:59:10.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:10.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:10.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:10.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:59:10.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/data
23:59:10.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/wal
23:59:10.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:59:10.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.253:45159
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39117/jwks.json
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/data/info.pb
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.253
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:10.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:59:10.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:10.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:59:10.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:59:10.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:10.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/logs
23:59:10.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:10.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:59:10.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:59:10.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
23:59:10.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
23:59:10.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
23:59:10.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
23:59:10.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 22:40:22 UTC on ccycloud.quasar-znwdty.root.comops.site
23:59:10.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492328
23:59:10.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
23:59:10.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.820202 29422 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:59:10.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.822212 29422 file_cache.cc:493] Constructed file cache file cache with capacity 419430
23:59:10.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.834189 29430 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
23:59:10.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.834132 29433 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
23:59:10.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.834136 29431 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
23:59:10.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.835223 29422 server_base.cc:1034] running on GCE node
23:59:10.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.836056 29422 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:59:10.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.837653 29422 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:59:10.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.838894 29422 hybrid_clock.cc:648] HybridClock initialized: now 1783468750838830 us; error 36 us; skew 500 ppm
23:59:10.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.839289 29422 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
23:59:10.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.841755 29422 webserver.cc:460] Webserver started at http://127.28.167.253:46591/ using document root <none> and password file <none>
23:59:10.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.842516 29422 fs_manager.cc:359] Metadata directory not provided
23:59:10.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.842665 29422 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:59:10.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.843057 29422 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
23:59:10.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.845932 29422 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/data/instance:
23:59:10.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "197f5c61c190468497515818edcd235b"
23:59:10.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:10 on dist-test-slave-5n60"
23:59:10.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.846909 29422 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/wal/instance:
23:59:10.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "197f5c61c190468497515818edcd235b"
23:59:10.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:10 on dist-test-slave-5n60"
23:59:10.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.852494 29422 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.006s	sys 0.000s
23:59:10.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.856199 29439 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:59:10.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.857646 29422 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
23:59:10.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.857862 29422 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/data,/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/wal
23:59:10.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "197f5c61c190468497515818edcd235b"
23:59:10.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:10 on dist-test-slave-5n60"
23:59:10.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.858134 29422 fs_report.cc:383] FS layout report
23:59:10.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:59:10.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/wal
23:59:10.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/wal
23:59:10.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/data/data
23:59:10.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:59:10.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:59:10.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:59:10.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:59:10.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:59:10.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:59:10.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:59:10.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:59:10.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:59:10.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:59:10.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:59:10.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.859115 29420 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } attempt: 4
23:59:10.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.861272 29420 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.253:45159: Network error: Client connection negotiation failed: client connection to 127.28.167.253:45159: connect: Connection refused (error 111)
23:59:10.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.882721 29422 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
23:59:10.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.883773 29422 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
23:59:10.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.884176 29422 kserver.cc:163] Server-wide thread pool size limit: 3276
23:59:10.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.903371 29422 rpc_server.cc:307] RPC server started. Bound to: 127.28.167.253:45159
23:59:10.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.903406 29490 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.28.167.253:45159 every 8 connection(s)
23:59:10.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.904929 29422 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/data/info.pb
23:59:10.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.908788 29491 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
23:59:10.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.910255 29343 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu as pid 29422
23:59:10.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.910430 29343 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-1/wal/instance
23:59:10.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.911674 29343 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/wal
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/data
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/logs
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/data/info.pb
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.252:41445
23:59:10.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.252
23:59:10.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:10.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:10.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:10.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:10.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:59:10.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:59:10.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:10.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:59:10.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39117/jwks.json with env {}
23:59:10.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.918526 29491 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } has no permanent_uuid. Determining permanent_uuid...
23:59:10.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.935240 29491 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } has no permanent_uuid. Determining permanent_uuid...
23:59:10.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.945479 29491 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } has no permanent_uuid. Determining permanent_uuid...
23:59:10.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.946646 29441 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.28.167.252:41445: connect: Connection refused (error 111)
23:59:10.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:10.948366 29491 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.252:41445: Network error: Client connection negotiation failed: client connection to 127.28.167.252:41445: connect: Connection refused (error 111)
23:59:10.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:10.997740 29491 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } attempt: 1
23:59:11.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.000079 29491 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.252:41445: Network error: Client connection negotiation failed: client connection to 127.28.167.252:41445: connect: Connection refused (error 111)
23:59:11.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.068395 29491 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } attempt: 2
23:59:11.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.070631 29491 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.252:41445: Network error: Client connection negotiation failed: client connection to 127.28.167.252:41445: connect: Connection refused (error 111)
23:59:11.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.160535 29420 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } attempt: 5
23:59:11.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.161813 29491 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } attempt: 3
23:59:11.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.163861 29491 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.252:41445: Network error: Client connection negotiation failed: client connection to 127.28.167.252:41445: connect: Connection refused (error 111)
23:59:11.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.169265 29420 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } has no permanent_uuid. Determining permanent_uuid...
23:59:11.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.171214 29420 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.252:41445: Network error: Client connection negotiation failed: client connection to 127.28.167.252:41445: connect: Connection refused (error 111)
23:59:11.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.222496 29420 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } attempt: 1
23:59:11.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.224794 29420 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.252:41445: Network error: Client connection negotiation failed: client connection to 127.28.167.252:41445: connect: Connection refused (error 111)
23:59:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.259958 29493 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
23:59:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.260250 29493 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:59:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.260337 29493 flags.cc:425] Enabled unsafe flag: --never_fsync=true
23:59:11.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.267805 29493 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
23:59:11.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.267918 29493 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
23:59:11.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.267961 29493 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
23:59:11.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.268007 29493 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
23:59:11.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.268044 29493 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
23:59:11.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.268093 29493 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:39117/jwks.json
23:59:11.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.277176 29493 master_runner.cc:386] Master server non-default flags:
23:59:11.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:11.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:11.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:11.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/data
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/wal
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.252:41445
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39117/jwks.json
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:11.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/data/info.pb
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.252
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/logs
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
23:59:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
23:59:11.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
23:59:11.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
23:59:11.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 22:40:22 UTC on ccycloud.quasar-znwdty.root.comops.site
23:59:11.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492328
23:59:11.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
23:59:11.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.278772 29493 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:59:11.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.281206 29493 file_cache.cc:493] Constructed file cache file cache with capacity 419430
23:59:11.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.293041 29420 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } attempt: 2
23:59:11.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.297246 29502 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
23:59:11.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.297811 29420 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.252:41445: Network error: Client connection negotiation failed: client connection to 127.28.167.252:41445: connect: Connection refused (error 111)
23:59:11.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.297681 29501 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
23:59:11.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.298810 29504 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
23:59:11.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.299078 29493 server_base.cc:1034] running on GCE node
23:59:11.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.299921 29493 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:59:11.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.301551 29493 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:59:11.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.302809 29493 hybrid_clock.cc:648] HybridClock initialized: now 1783468751302730 us; error 71 us; skew 500 ppm
23:59:11.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.303143 29493 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
23:59:11.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.305583 29493 webserver.cc:460] Webserver started at http://127.28.167.252:44693/ using document root <none> and password file <none>
23:59:11.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.306272 29493 fs_manager.cc:359] Metadata directory not provided
23:59:11.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.306377 29493 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:59:11.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.306636 29493 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
23:59:11.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.307091 29491 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } attempt: 4
23:59:11.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.308952 29491 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.28.167.252:41445: Network error: Client connection negotiation failed: client connection to 127.28.167.252:41445: connect: Connection refused (error 111)
23:59:11.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.309873 29493 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/data/instance:
23:59:11.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "349789498ea94db18b246b392de6a0e6"
23:59:11.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:11 on dist-test-slave-5n60"
23:59:11.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.310712 29493 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/wal/instance:
23:59:11.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "349789498ea94db18b246b392de6a0e6"
23:59:11.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:11 on dist-test-slave-5n60"
23:59:11.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.316229 29493 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.006s	sys 0.000s
23:59:11.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.319630 29510 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.321290 29493 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.321431 29493 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/data,/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/wal
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "349789498ea94db18b246b392de6a0e6"
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:11 on dist-test-slave-5n60"
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.321607 29493 fs_report.cc:383] FS layout report
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/wal
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/wal
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/data/data
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:59:11.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:59:11.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:59:11.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:59:11.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:59:11.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:59:11.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:59:11.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:59:11.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:59:11.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:59:11.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.352178 29493 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
23:59:11.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.353101 29493 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
23:59:11.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.353428 29493 kserver.cc:163] Server-wide thread pool size limit: 3276
23:59:11.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.371616 29493 rpc_server.cc:307] RPC server started. Bound to: 127.28.167.252:41445
23:59:11.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.371639 29561 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.28.167.252:41445 every 8 connection(s)
23:59:11.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.372859 29493 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/data/info.pb
23:59:11.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.376442 29562 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
23:59:11.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.381421 29343 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu as pid 29493
23:59:11.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.381563 29343 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/master-2/wal/instance
23:59:11.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.383437 29562 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } has no permanent_uuid. Determining permanent_uuid...
23:59:11.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.404075 29420 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } attempt: 3
23:59:11.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.406908 29562 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } has no permanent_uuid. Determining permanent_uuid...
23:59:11.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.415794 29562 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } has no permanent_uuid. Determining permanent_uuid...
23:59:11.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.422173 29420 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09: Bootstrap starting.
23:59:11.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.427390 29420 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09: Neither blocks nor log segments found. Creating new log.
23:59:11.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.428768 29562 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6: Bootstrap starting.
23:59:11.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.428805 29420 log.cc:824] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09: Log is configured to *not* fsync() on all Append() calls
23:59:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.431859 29420 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09: No bootstrap required, opened a new log
23:59:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.432264 29562 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6: Neither blocks nor log segments found. Creating new log.
23:59:11.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.433440 29562 log.cc:824] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6: Log is configured to *not* fsync() on all Append() calls
23:59:11.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.436213 29562 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6: No bootstrap required, opened a new log
23:59:11.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.439764 29420 raft_consensus.cc:348] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } }
23:59:11.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.440094 29420 raft_consensus.cc:374] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:59:11.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.440172 29420 raft_consensus.cc:729] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b37b50cb30804e45ad834c217af35f09, State: Initialized, Role: FOLLOWER
23:59:11.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.440740 29420 consensus_queue.cc:260] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [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: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } }
23:59:11.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.441701 29572 sys_catalog.cc:455] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [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: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } } }
23:59:11.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.442348 29572 sys_catalog.cc:458] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [sys.catalog]: This master's current role is: FOLLOWER
23:59:11.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.443068 29420 sys_catalog.cc:564] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [sys.catalog]: configured and running, proceeding with master startup.
23:59:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.444922 29562 raft_consensus.cc:348] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } }
23:59:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.445533 29562 raft_consensus.cc:374] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:59:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.445792 29562 raft_consensus.cc:729] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 349789498ea94db18b246b392de6a0e6, State: Initialized, Role: FOLLOWER
23:59:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.445798 29374 tablet.cc:2369] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:59:11.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.446802 29562 consensus_queue.cc:260] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [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: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } }
23:59:11.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.448047 29578 sys_catalog.cc:455] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [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: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } } }
23:59:11.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.448637 29578 sys_catalog.cc:458] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [sys.catalog]: This master's current role is: FOLLOWER
23:59:11.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.449458 29562 sys_catalog.cc:564] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [sys.catalog]: configured and running, proceeding with master startup.
23:59:11.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.473455 29586 catalog_manager.cc:1558] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
23:59:11.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.463058 29493 master_runner.cc:186] Error getting master registration for 127.28.167.253:45159: OK, instance_id { permanent_uuid: "197f5c61c190468497515818edcd235b" instance_seqno: 1783468750898067 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
23:59:11.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.481189 29493 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
23:59:11.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.487682 29586 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
23:59:11.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.455787 29354 master_runner.cc:186] Error getting master registration for 127.28.167.253:45159: OK, instance_id { permanent_uuid: "197f5c61c190468497515818edcd235b" instance_seqno: 1783468750898067 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
23:59:11.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.489722 29354 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
23:59:11.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.492959 29596 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
23:59:11.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.493345 29596 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
23:59:11.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.562562 29572 raft_consensus.cc:482] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
23:59:11.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.562922 29572 raft_consensus.cc:504] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } }
23:59:11.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.564631 29572 leader_election.cc:288] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 197f5c61c190468497515818edcd235b (127.28.167.253:45159), 349789498ea94db18b246b392de6a0e6 (127.28.167.252:41445)
23:59:11.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.565546 29537 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "b37b50cb30804e45ad834c217af35f09" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "349789498ea94db18b246b392de6a0e6" is_pre_election: true
23:59:11.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.566174 29537 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate b37b50cb30804e45ad834c217af35f09 in term 0.
23:59:11.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.566821 29370 leader_election.cc:302] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [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: 349789498ea94db18b246b392de6a0e6, b37b50cb30804e45ad834c217af35f09; no voters: 
23:59:11.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.567274 29572 raft_consensus.cc:2781] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [term 0 FOLLOWER]: Leader pre-election won for term 1
23:59:11.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.567415 29572 raft_consensus.cc:482] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
23:59:11.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.567518 29572 raft_consensus.cc:3037] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [term 0 FOLLOWER]: Advancing to term 1
23:59:11.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.576759 29572 raft_consensus.cc:504] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } }
23:59:11.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.581207 29572 leader_election.cc:288] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [CANDIDATE]: Term 1 election: Requested vote from peers 197f5c61c190468497515818edcd235b (127.28.167.253:45159), 349789498ea94db18b246b392de6a0e6 (127.28.167.252:41445)
23:59:11.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.581357 29537 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "b37b50cb30804e45ad834c217af35f09" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "349789498ea94db18b246b392de6a0e6"
23:59:11.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.581590 29537 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [term 0 FOLLOWER]: Advancing to term 1
23:59:11.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.585021 29537 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate b37b50cb30804e45ad834c217af35f09 in term 1.
23:59:11.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.585546 29370 leader_election.cc:302] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [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: 349789498ea94db18b246b392de6a0e6, b37b50cb30804e45ad834c217af35f09; no voters: 
23:59:11.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.585973 29572 raft_consensus.cc:2781] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [term 1 FOLLOWER]: Leader election won for term 1
23:59:11.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.586632 29572 raft_consensus.cc:686] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [term 1 LEADER]: Becoming Leader. State: Replica: b37b50cb30804e45ad834c217af35f09, State: Running, Role: LEADER
23:59:11.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.587443 29572 consensus_queue.cc:237] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [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: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } }
23:59:11.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.598338 29598 sys_catalog.cc:455] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [sys.catalog]: SysCatalogTable state changed. Reason: New leader b37b50cb30804e45ad834c217af35f09. Latest consensus state: current_term: 1 leader_uuid: "b37b50cb30804e45ad834c217af35f09" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } } }
23:59:11.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.598799 29598 sys_catalog.cc:458] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [sys.catalog]: This master's current role is: LEADER
23:59:11.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:11.605520 29516 tablet.cc:2369] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:59:11.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.608129 29491 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } attempt: 5
23:59:11.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.608428 29600 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
23:59:11.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.610850 29600 catalog_manager.cc:1484] Initializing Kudu cluster ID...
23:59:11.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.626631 29491 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b: Bootstrap starting.
23:59:11.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.635084 29491 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b: Neither blocks nor log segments found. Creating new log.
23:59:11.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.638202 29491 log.cc:824] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b: Log is configured to *not* fsync() on all Append() calls
23:59:11.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.653604 29537 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [term 1 FOLLOWER]: Refusing update from remote peer b37b50cb30804e45ad834c217af35f09: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
23:59:11.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.655056 29572 consensus_queue.cc:1035] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [LEADER]: Connected to new peer: Peer: permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:59:11.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.666071 29491 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b: No bootstrap required, opened a new log
23:59:11.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.682452 29578 sys_catalog.cc:455] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [sys.catalog]: SysCatalogTable state changed. Reason: New leader b37b50cb30804e45ad834c217af35f09. Latest consensus state: current_term: 1 leader_uuid: "b37b50cb30804e45ad834c217af35f09" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } } }
23:59:11.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.682847 29578 sys_catalog.cc:458] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [sys.catalog]: This master's current role is: FOLLOWER
23:59:11.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.688272 29491 raft_consensus.cc:348] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } }
23:59:11.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.689035 29491 raft_consensus.cc:374] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:59:11.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.689266 29491 raft_consensus.cc:729] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 197f5c61c190468497515818edcd235b, State: Initialized, Role: FOLLOWER
23:59:11.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.690201 29491 consensus_queue.cc:260] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [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: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } }
23:59:11.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.704314 29491 sys_catalog.cc:564] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [sys.catalog]: configured and running, proceeding with master startup.
23:59:11.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.704723 29464 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [term 0 FOLLOWER]: Advancing to term 1
23:59:11.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.705312 29465 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "b37b50cb30804e45ad834c217af35f09" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "197f5c61c190468497515818edcd235b"
23:59:11.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.706236 29466 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "b37b50cb30804e45ad834c217af35f09" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "197f5c61c190468497515818edcd235b" is_pre_election: true
23:59:11.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.711238 29464 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [term 1 FOLLOWER]: Refusing update from remote peer b37b50cb30804e45ad834c217af35f09: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
23:59:11.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.711339 29603 mvcc.cc:205] Tried to move back new op lower bound from 7305088006752382976 to 7305088006507098112. Current Snapshot: MvccSnapshot[applied={T|T < 7305088006752382976}]
23:59:11.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.712688 29572 consensus_queue.cc:1035] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [LEADER]: Connected to new peer: Peer: permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:59:11.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.726131 29598 sys_catalog.cc:455] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "b37b50cb30804e45ad834c217af35f09" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } } }
23:59:11.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.726806 29598 sys_catalog.cc:458] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [sys.catalog]: This master's current role is: LEADER
23:59:11.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.726751 29578 sys_catalog.cc:455] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "b37b50cb30804e45ad834c217af35f09" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } } }
23:59:11.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.727017 29578 sys_catalog.cc:458] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6 [sys.catalog]: This master's current role is: FOLLOWER
23:59:11.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.734126 29600 catalog_manager.cc:1347] Generated new cluster ID: 6b80853f73054353b2538359fded83af
23:59:11.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.734254 29600 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
23:59:11.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.752642 29600 catalog_manager.cc:1370] Generated new certificate authority record
23:59:11.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.755064 29600 catalog_manager.cc:1504] Loading token signing keys...
23:59:11.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.762591 29572 sys_catalog.cc:455] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "b37b50cb30804e45ad834c217af35f09" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } } }
23:59:11.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.762506 29605 sys_catalog.cc:455] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "b37b50cb30804e45ad834c217af35f09" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } } }
23:59:11.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.762938 29605 sys_catalog.cc:458] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [sys.catalog]: This master's current role is: FOLLOWER
23:59:11.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.762931 29572 sys_catalog.cc:458] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09 [sys.catalog]: This master's current role is: LEADER
23:59:11.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.763422 29610 sys_catalog.cc:455] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [sys.catalog]: SysCatalogTable state changed. Reason: New leader b37b50cb30804e45ad834c217af35f09. Latest consensus state: current_term: 1 leader_uuid: "b37b50cb30804e45ad834c217af35f09" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } } }
23:59:11.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.763772 29610 sys_catalog.cc:458] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [sys.catalog]: This master's current role is: FOLLOWER
23:59:11.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.766049 29618 sys_catalog.cc:455] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "b37b50cb30804e45ad834c217af35f09" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b37b50cb30804e45ad834c217af35f09" member_type: VOTER last_known_addr { host: "127.28.167.254" port: 33339 } } peers { permanent_uuid: "197f5c61c190468497515818edcd235b" member_type: VOTER last_known_addr { host: "127.28.167.253" port: 45159 } } peers { permanent_uuid: "349789498ea94db18b246b392de6a0e6" member_type: VOTER last_known_addr { host: "127.28.167.252" port: 41445 } } }
23:59:11.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.766650 29618 sys_catalog.cc:458] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b [sys.catalog]: This master's current role is: FOLLOWER
23:59:11.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.769119 29600 catalog_manager.cc:5868] T 00000000000000000000000000000000 P b37b50cb30804e45ad834c217af35f09: Generated new TSK 0
23:59:11.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.770291 29600 catalog_manager.cc:1514] Initializing in-progress tserver states...
23:59:11.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.779743 29624 catalog_manager.cc:795] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
23:59:11.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:11.783529 29343 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:11.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:11.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/wal
23:59:11.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/data
23:59:11.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:59:11.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:59:11.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:59:11.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:11.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:11.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:11.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/logs
23:59:11.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/data/info.pb
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.193:0
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.167.193
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.193
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:11.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
23:59:12.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.206453 29625 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
23:59:12.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.206713 29625 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:59:12.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.206792 29625 flags.cc:425] Enabled unsafe flag: --never_fsync=true
23:59:12.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.213960 29625 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
23:59:12.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.214138 29625 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.28.167.193
23:59:12.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.223591 29625 tablet_server_runner.cc:78] Tablet server non-default flags:
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/data
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/wal
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.193:0
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/data/info.pb
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.193
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.167.193
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/logs
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 22:40:22 UTC on ccycloud.quasar-znwdty.root.comops.site
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492328
23:59:12.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
23:59:12.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.224906 29625 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:59:12.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.226756 29625 file_cache.cc:493] Constructed file cache file cache with capacity 419430
23:59:12.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.239605 29630 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
23:59:12.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.239558 29631 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
23:59:12.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.239796 29633 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
23:59:12.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.240764 29625 server_base.cc:1034] running on GCE node
23:59:12.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.241379 29625 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:59:12.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.242308 29625 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:59:12.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.243549 29625 hybrid_clock.cc:648] HybridClock initialized: now 1783468752243481 us; error 44 us; skew 500 ppm
23:59:12.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.243891 29625 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
23:59:12.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.246479 29625 webserver.cc:460] Webserver started at http://127.28.167.193:38707/ using document root <none> and password file <none>
23:59:12.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.247172 29625 fs_manager.cc:359] Metadata directory not provided
23:59:12.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.247314 29625 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:59:12.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.247634 29625 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
23:59:12.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.250376 29625 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/data/instance:
23:59:12.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6264e5f880454946a9a7f9a76c5f99e0"
23:59:12.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:12 on dist-test-slave-5n60"
23:59:12.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.251185 29625 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/wal/instance:
23:59:12.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6264e5f880454946a9a7f9a76c5f99e0"
23:59:12.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:12 on dist-test-slave-5n60"
23:59:12.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.256477 29625 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.006s	sys 0.000s
23:59:12.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.259936 29639 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:59:12.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.261205 29625 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
23:59:12.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.261446 29625 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/data,/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/wal
23:59:12.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6264e5f880454946a9a7f9a76c5f99e0"
23:59:12.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:12 on dist-test-slave-5n60"
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.261672 29625 fs_report.cc:383] FS layout report
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/wal
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/wal
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/data/data
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:59:12.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:59:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.286572 29625 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
23:59:12.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.287585 29625 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
23:59:12.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.287950 29625 kserver.cc:163] Server-wide thread pool size limit: 3276
23:59:12.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.289029 29625 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
23:59:12.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.290632 29625 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:59:12.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.290741 29625 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:59:12.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.290863 29625 ts_tablet_manager.cc:610] Registered 0 tablets
23:59:12.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.290925 29625 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:59:12.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.323933 29625 rpc_server.cc:307] RPC server started. Bound to: 127.28.167.193:42445
23:59:12.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.324023 29751 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.28.167.193:42445 every 8 connection(s)
23:59:12.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.325346 29625 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/data/info.pb
23:59:12.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.327394 29343 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu as pid 29625
23:59:12.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.327607 29343 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-0/wal/instance
23:59:12.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.333592 29343 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:12.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:12.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/wal
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/data
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/logs
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/data/info.pb
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:59:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.194:0
23:59:12.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.167.194
23:59:12.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.194
23:59:12.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:12.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:12.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:12.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:12.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:12.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
23:59:12.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.361845 29752 heartbeater.cc:347] Connected to a master server at 127.28.167.252:41445
23:59:12.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.361881 29754 heartbeater.cc:347] Connected to a master server at 127.28.167.253:45159
23:59:12.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.361856 29753 heartbeater.cc:347] Connected to a master server at 127.28.167.254:33339
23:59:12.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.362280 29752 heartbeater.cc:464] Registering TS with master...
23:59:12.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.362282 29754 heartbeater.cc:464] Registering TS with master...
23:59:12.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.362283 29753 heartbeater.cc:464] Registering TS with master...
23:59:12.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.363495 29752 heartbeater.cc:511] Master 127.28.167.252:41445 requested a full tablet report, sending...
23:59:12.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.363643 29754 heartbeater.cc:511] Master 127.28.167.253:45159 requested a full tablet report, sending...
23:59:12.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.363933 29753 heartbeater.cc:511] Master 127.28.167.254:33339 requested a full tablet report, sending...
23:59:12.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.366113 29385 ts_manager.cc:194] Registered new tserver with Master: 6264e5f880454946a9a7f9a76c5f99e0 (127.28.167.193:42445)
23:59:12.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.366130 29456 ts_manager.cc:194] Registered new tserver with Master: 6264e5f880454946a9a7f9a76c5f99e0 (127.28.167.193:42445)
23:59:12.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.366418 29527 ts_manager.cc:194] Registered new tserver with Master: 6264e5f880454946a9a7f9a76c5f99e0 (127.28.167.193:42445)
23:59:12.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.367756 29385 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.28.167.193:36217
23:59:12.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.495504 29596 catalog_manager.cc:1259] Loaded cluster ID: 6b80853f73054353b2538359fded83af
23:59:12.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.495661 29596 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6: loading cluster ID for follower catalog manager: success
23:59:12.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.498275 29596 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6: acquiring CA information for follower catalog manager: success
23:59:12.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.500015 29596 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 349789498ea94db18b246b392de6a0e6: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
23:59:12.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.692643 29762 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
23:59:12.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.692997 29762 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:59:12.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.693084 29762 flags.cc:425] Enabled unsafe flag: --never_fsync=true
23:59:12.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.700568 29762 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
23:59:12.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.700767 29762 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.28.167.194
23:59:12.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.711225 29762 tablet_server_runner.cc:78] Tablet server non-default flags:
23:59:12.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/data
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/wal
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.194:0
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/data/info.pb
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.194
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.167.194
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/logs
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 22:40:22 UTC on ccycloud.quasar-znwdty.root.comops.site
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492328
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
23:59:12.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.712574 29762 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:59:12.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.714433 29762 file_cache.cc:493] Constructed file cache file cache with capacity 419430
23:59:12.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.727950 29769 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
23:59:12.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.728029 29770 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
23:59:12.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:12.727931 29772 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
23:59:12.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.730904 29762 server_base.cc:1034] running on GCE node
23:59:12.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.731621 29762 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:59:12.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.732617 29762 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:59:12.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.733844 29762 hybrid_clock.cc:648] HybridClock initialized: now 1783468752733754 us; error 50 us; skew 500 ppm
23:59:12.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.734110 29762 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
23:59:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.736678 29762 webserver.cc:460] Webserver started at http://127.28.167.194:35019/ using document root <none> and password file <none>
23:59:12.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.737394 29762 fs_manager.cc:359] Metadata directory not provided
23:59:12.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.737507 29762 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:59:12.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.737815 29762 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
23:59:12.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.740423 29762 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/data/instance:
23:59:12.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0320b0f656654782ad9ec54cef621a9b"
23:59:12.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:12 on dist-test-slave-5n60"
23:59:12.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.741163 29762 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/wal/instance:
23:59:12.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0320b0f656654782ad9ec54cef621a9b"
23:59:12.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:12 on dist-test-slave-5n60"
23:59:12.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.746455 29762 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.003s	sys 0.001s
23:59:12.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.749938 29778 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:59:12.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.751325 29762 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.751505 29762 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/data,/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/wal
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0320b0f656654782ad9ec54cef621a9b"
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:12 on dist-test-slave-5n60"
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.751704 29762 fs_report.cc:383] FS layout report
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/wal
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/wal
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/data/data
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:59:12.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:59:12.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.781524 29762 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
23:59:12.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.782545 29762 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
23:59:12.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.782920 29762 kserver.cc:163] Server-wide thread pool size limit: 3276
23:59:12.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.784119 29762 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
23:59:12.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.784825 29624 catalog_manager.cc:1259] Loaded cluster ID: 6b80853f73054353b2538359fded83af
23:59:12.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.784958 29624 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b: loading cluster ID for follower catalog manager: success
23:59:12.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.786003 29762 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:59:12.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.786109 29762 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:59:12.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.786242 29762 ts_tablet_manager.cc:610] Registered 0 tablets
23:59:12.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.786325 29762 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:59:12.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.789196 29624 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b: acquiring CA information for follower catalog manager: success
23:59:12.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.791743 29624 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 197f5c61c190468497515818edcd235b: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
23:59:12.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.824420 29762 rpc_server.cc:307] RPC server started. Bound to: 127.28.167.194:33971
23:59:12.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.824460 29891 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.28.167.194:33971 every 8 connection(s)
23:59:12.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.826179 29762 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/data/info.pb
23:59:12.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.829082 29343 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu as pid 29762
23:59:12.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.829262 29343 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-1/wal/instance
23:59:12.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.837502 29343 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:12.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu
23:59:12.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/wal
23:59:12.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/data
23:59:12.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/logs
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/data/info.pb
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:59:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:59:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.195:0
23:59:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.167.195
23:59:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.195
23:59:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
23:59:12.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.865600 29892 heartbeater.cc:347] Connected to a master server at 127.28.167.252:41445
23:59:12.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.865919 29892 heartbeater.cc:464] Registering TS with master...
23:59:12.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.867071 29892 heartbeater.cc:511] Master 127.28.167.252:41445 requested a full tablet report, sending...
23:59:12.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.869550 29527 ts_manager.cc:194] Registered new tserver with Master: 0320b0f656654782ad9ec54cef621a9b (127.28.167.194:33971)
23:59:12.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.872757 29893 heartbeater.cc:347] Connected to a master server at 127.28.167.254:33339
23:59:12.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.872901 29893 heartbeater.cc:464] Registering TS with master...
23:59:12.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.873351 29893 heartbeater.cc:511] Master 127.28.167.254:33339 requested a full tablet report, sending...
23:59:12.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.874709 29385 ts_manager.cc:194] Registered new tserver with Master: 0320b0f656654782ad9ec54cef621a9b (127.28.167.194:33971)
23:59:12.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.874787 29894 heartbeater.cc:347] Connected to a master server at 127.28.167.253:45159
23:59:12.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.874893 29894 heartbeater.cc:464] Registering TS with master...
23:59:12.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.875258 29894 heartbeater.cc:511] Master 127.28.167.253:45159 requested a full tablet report, sending...
23:59:12.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.875815 29385 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.28.167.194:54473
23:59:12.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:12.876259 29456 ts_manager.cc:194] Registered new tserver with Master: 0320b0f656654782ad9ec54cef621a9b (127.28.167.194:33971)
23:59:13.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:13.202144 29898 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
23:59:13.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:13.202454 29898 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:59:13.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:13.202538 29898 flags.cc:425] Enabled unsafe flag: --never_fsync=true
23:59:13.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:13.210084 29898 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
23:59:13.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:13.210274 29898 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.28.167.195
23:59:13.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.219498 29898 tablet_server_runner.cc:78] Tablet server non-default flags:
23:59:13.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:59:13.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.167.212:39569
23:59:13.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:59:13.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:59:13.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/data
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/wal
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.167.195:0
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/data/info.pb
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.167.195
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.167.254:33339,127.28.167.253:45159,127.28.167.252:41445
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.167.195
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/logs
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 22:40:22 UTC on ccycloud.quasar-znwdty.root.comops.site
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492328
23:59:13.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
23:59:13.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.220908 29898 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:59:13.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.222623 29898 file_cache.cc:493] Constructed file cache file cache with capacity 419430
23:59:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:13.236514 29905 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
23:59:13.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:13.236595 29906 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
23:59:13.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:59:13.236547 29908 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
23:59:13.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.237432 29898 server_base.cc:1034] running on GCE node
23:59:13.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.238300 29898 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:59:13.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.239301 29898 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:59:13.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.240550 29898 hybrid_clock.cc:648] HybridClock initialized: now 1783468753240492 us; error 26 us; skew 500 ppm
23:59:13.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.240900 29898 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
23:59:13.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.243461 29898 webserver.cc:460] Webserver started at http://127.28.167.195:44585/ using document root <none> and password file <none>
23:59:13.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.244213 29898 fs_manager.cc:359] Metadata directory not provided
23:59:13.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.244362 29898 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:59:13.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.244704 29898 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
23:59:13.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.247637 29898 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/data/instance:
23:59:13.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7b38afae61a348aea641e7fbfaf1bde5"
23:59:13.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:13 on dist-test-slave-5n60"
23:59:13.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.248479 29898 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/wal/instance:
23:59:13.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7b38afae61a348aea641e7fbfaf1bde5"
23:59:13.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:13 on dist-test-slave-5n60"
23:59:13.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.253966 29898 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.006s	sys 0.001s
23:59:13.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.257498 29914 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.259052 29898 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.000s	sys 0.004s
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.259187 29898 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/data,/tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/wal
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7b38afae61a348aea641e7fbfaf1bde5"
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:59:13 on dist-test-slave-5n60"
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.259357 29898 fs_report.cc:383] FS layout report
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/wal
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/wal
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/data/data
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:59:13.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:59:13.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.285017 29898 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
23:59:13.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.285938 29898 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
23:59:13.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.286198 29898 kserver.cc:163] Server-wide thread pool size limit: 3276
23:59:13.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.287210 29898 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
23:59:13.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.291455 29898 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:59:13.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.291572 29898 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:59:13.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.291698 29898 ts_tablet_manager.cc:610] Registered 0 tablets
23:59:13.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.291759 29898 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:59:13.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.326534 29898 rpc_server.cc:307] RPC server started. Bound to: 127.28.167.195:33267
23:59:13.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.326586 30026 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.28.167.195:33267 every 8 connection(s)
23:59:13.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.327920 29898 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/data/info.pb
23:59:13.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.337314 29343 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu as pid 29898
23:59:13.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.337482 29343 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskOhPADJ/test-tmp/mini-kudu-cluster9067991227154357422/ts-2/wal/instance
23:59:13.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.348728 30029 heartbeater.cc:347] Connected to a master server at 127.28.167.253:45159
23:59:13.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.348774 30028 heartbeater.cc:347] Connected to a master server at 127.28.167.254:33339
23:59:13.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.348819 30027 heartbeater.cc:347] Connected to a master server at 127.28.167.252:41445
23:59:13.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.349184 30027 heartbeater.cc:464] Registering TS with master...
23:59:13.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.349179 30029 heartbeater.cc:464] Registering TS with master...
23:59:13.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.349181 30028 heartbeater.cc:464] Registering TS with master...
23:59:13.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.350252 30028 heartbeater.cc:511] Master 127.28.167.254:33339 requested a full tablet report, sending...
23:59:13.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.350301 30029 heartbeater.cc:511] Master 127.28.167.253:45159 requested a full tablet report, sending...
23:59:13.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.350344 30027 heartbeater.cc:511] Master 127.28.167.252:41445 requested a full tablet report, sending...
23:59:13.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.352010 29527 ts_manager.cc:194] Registered new tserver with Master: 7b38afae61a348aea641e7fbfaf1bde5 (127.28.167.195:33267)
23:59:13.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.352039 29385 ts_manager.cc:194] Registered new tserver with Master: 7b38afae61a348aea641e7fbfaf1bde5 (127.28.167.195:33267)
23:59:13.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.352095 29456 ts_manager.cc:194] Registered new tserver with Master: 7b38afae61a348aea641e7fbfaf1bde5 (127.28.167.195:33267)
23:59:13.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.353082 29385 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.28.167.195:55133
23:59:13.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.363343 29343 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
23:59:13.365 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
23:59:13.366 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

23:59:13.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.370800 29753 heartbeater.cc:503] Master 127.28.167.254:33339 was elected leader, sending a full tablet report...
23:59:13.377 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.28.167.254"
      port: 33339
    }
    bound_http_address {
      host: "127.28.167.254"
      port: 44801
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.28.167.253"
      port: 45159
    }
    bound_http_address {
      host: "127.28.167.253"
      port: 46591
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.28.167.252"
      port: 41445
    }
    bound_http_address {
      host: "127.28.167.252"
      port: 44693
    }
  }
}

23:59:13.386 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

23:59:13.389 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.28.167.193"
      port: 42445
    }
    bound_http_address {
      host: "127.28.167.193"
      port: 38707
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.28.167.194"
      port: 33971
    }
    bound_http_address {
      host: "127.28.167.194"
      port: 35019
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.28.167.195"
      port: 33267
    }
    bound_http_address {
      host: "127.28.167.195"
      port: 44585
    }
  }
}

23:59:13.392 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
23:59:13.400 [DEBUG - main] (InternalLoggerFactory.java:63) Using SLF4J as the default logging framework
23:59:13.404 [DEBUG - main] (ResourceLeakDetector.java:129) -Dorg.apache.kudu.shaded.io.netty.leakDetection.level: simple
23:59:13.404 [DEBUG - main] (ResourceLeakDetector.java:130) -Dorg.apache.kudu.shaded.io.netty.leakDetection.targetRecords: 4
23:59:13.412 [DEBUG - main] (ResourceLeakDetectorFactory.java:196) Loaded default ResourceLeakDetector: org.apache.kudu.shaded.io.netty.util.ResourceLeakDetector@68044f4
23:59:13.432 [DEBUG - main] (PlatformDependent0.java:497) -Dio.netty.noUnsafe: false
23:59:13.432 [DEBUG - main] (PlatformDependent0.java:1001) Java version: 8
23:59:13.433 [DEBUG - main] (PlatformDependent0.java:137) sun.misc.Unsafe.theUnsafe: available
23:59:13.434 [DEBUG - main] (PlatformDependent0.java:161) sun.misc.Unsafe.copyMemory: available
23:59:13.435 [DEBUG - main] (PlatformDependent0.java:193) sun.misc.Unsafe.storeFence: available
23:59:13.435 [DEBUG - main] (PlatformDependent0.java:236) java.nio.Buffer.address: available
23:59:13.436 [DEBUG - main] (PlatformDependent0.java:308) direct buffer constructor: available
23:59:13.436 [DEBUG - main] (PlatformDependent0.java:386) java.nio.Bits.unaligned: available, true
23:59:13.436 [DEBUG - main] (PlatformDependent0.java:460) jdk.internal.misc.Unsafe.allocateUninitializedArray(int): unavailable prior to Java9
23:59:13.436 [DEBUG - main] (PlatformDependent0.java:483) java.nio.DirectByteBuffer.<init>(long, {int,long}): available
23:59:13.436 [DEBUG - main] (PlatformDependent.java:1159) sun.misc.Unsafe: available
23:59:13.437 [DEBUG - main] (PlatformDependent.java:1289) -Dio.netty.tmpdir: /tmp (java.io.tmpdir)
23:59:13.437 [DEBUG - main] (PlatformDependent.java:1368) -Dio.netty.bitMode: 64 (sun.arch.data.model)
23:59:13.438 [DEBUG - main] (PlatformDependent.java:178) -Dio.netty.maxDirectMemory: 3799121920 bytes
23:59:13.438 [DEBUG - main] (PlatformDependent.java:185) -Dio.netty.uninitializedArrayAllocationThreshold: -1
23:59:13.439 [DEBUG - main] (CleanerJava6.java:92) java.nio.ByteBuffer.cleaner(): available
23:59:13.439 [DEBUG - main] (PlatformDependent.java:205) -Dio.netty.noPreferDirect: false
23:59:13.448 [DEBUG - main] (PlatformDependent.java:1010) org.jctools-core.MpscChunkedArrayQueue: available
23:59:13.490 [DEBUG - main] (MultithreadEventLoopGroup.java:44) -Dio.netty.eventLoopThreads: 2
23:59:13.502 [DEBUG - main] (GlobalEventExecutor.java:53) -Dio.netty.globalEventExecutor.quietPeriodSeconds: 1
23:59:13.508 [DEBUG - main] (InternalThreadLocalMap.java:100) -Dio.netty.threadLocalMap.stringBuilder.initialSize: 1024
23:59:13.508 [DEBUG - main] (InternalThreadLocalMap.java:101) -Dio.netty.threadLocalMap.stringBuilder.maxSize: 4096
23:59:13.515 [DEBUG - main] (NioEventLoop.java:110) -Dio.netty.noKeySetOptimization: false
23:59:13.516 [DEBUG - main] (NioEventLoop.java:111) -Dio.netty.selectorAutoRebuildThreshold: 512
23:59:13.552 [DEBUG - main] (PooledByteBufAllocator.java:157) -Dio.netty.allocator.numHeapArenas: 2
23:59:13.552 [DEBUG - main] (PooledByteBufAllocator.java:158) -Dio.netty.allocator.numDirectArenas: 2
23:59:13.552 [DEBUG - main] (PooledByteBufAllocator.java:160) -Dio.netty.allocator.pageSize: 8192
23:59:13.552 [DEBUG - main] (PooledByteBufAllocator.java:165) -Dio.netty.allocator.maxOrder: 9
23:59:13.552 [DEBUG - main] (PooledByteBufAllocator.java:169) -Dio.netty.allocator.chunkSize: 4194304
23:59:13.552 [DEBUG - main] (PooledByteBufAllocator.java:170) -Dio.netty.allocator.smallCacheSize: 256
23:59:13.552 [DEBUG - main] (PooledByteBufAllocator.java:171) -Dio.netty.allocator.normalCacheSize: 64
23:59:13.552 [DEBUG - main] (PooledByteBufAllocator.java:172) -Dio.netty.allocator.maxCachedBufferCapacity: 32768
23:59:13.552 [DEBUG - main] (PooledByteBufAllocator.java:173) -Dio.netty.allocator.cacheTrimInterval: 8192
23:59:13.552 [DEBUG - main] (PooledByteBufAllocator.java:174) -Dio.netty.allocator.cacheTrimIntervalMillis: 0
23:59:13.553 [DEBUG - main] (PooledByteBufAllocator.java:175) -Dio.netty.allocator.useCacheForAllThreads: false
23:59:13.553 [DEBUG - main] (PooledByteBufAllocator.java:176) -Dio.netty.allocator.maxCachedByteBuffersPerChunk: 1023
23:59:13.608 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
23:59:13.802 [INFO - main] (Logging.scala:57) Running Spark version 3.1.2
23:59:13.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:13.878921 29893 heartbeater.cc:503] Master 127.28.167.254:33339 was elected leader, sending a full tablet report...
23:59:14.059 [WARN - main] (NativeCodeLoader.java:60) Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
23:59:14.176 [INFO - main] (Logging.scala:57) ==============================================================
23:59:14.177 [INFO - main] (Logging.scala:57) No custom resources configured for spark.driver.
23:59:14.178 [INFO - main] (Logging.scala:57) ==============================================================
23:59:14.178 [INFO - main] (Logging.scala:57) Submitted application: test
23:59:14.209 [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)
23:59:14.227 [INFO - main] (Logging.scala:57) Limiting resource is cpu
23:59:14.228 [INFO - main] (Logging.scala:57) Added ResourceProfile id: 0
23:59:14.352 [INFO - main] (Logging.scala:57) Changing view acls to: slave
23:59:14.353 [INFO - main] (Logging.scala:57) Changing modify acls to: slave
23:59:14.354 [INFO - main] (Logging.scala:57) Changing view acls groups to: 
23:59:14.355 [INFO - main] (Logging.scala:57) Changing modify acls groups to: 
23:59:14.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:14.355293 30028 heartbeater.cc:503] Master 127.28.167.254:33339 was elected leader, sending a full tablet report...
23:59:14.356 [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()
23:59:14.706 [INFO - main] (Logging.scala:57) Successfully started service 'sparkDriver' on port 41885.
23:59:14.749 [INFO - main] (Logging.scala:57) Registering MapOutputTracker
23:59:14.788 [INFO - main] (Logging.scala:57) Registering BlockManagerMaster
23:59:14.812 [INFO - main] (Logging.scala:57) Using org.apache.spark.storage.DefaultTopologyMapper for getting topology information
23:59:14.813 [INFO - main] (Logging.scala:57) BlockManagerMasterEndpoint up
23:59:14.818 [INFO - main] (Logging.scala:57) Registering BlockManagerMasterHeartbeat
23:59:14.836 [INFO - main] (Logging.scala:57) Created local directory at /tmp/blockmgr-595e1b14-6a41-4746-b977-a738cde10650
23:59:14.889 [INFO - main] (Logging.scala:57) MemoryStore started with capacity 1993.9 MiB
23:59:14.911 [INFO - main] (Logging.scala:57) Registering OutputCommitCoordinator
23:59:15.103 [INFO - main] (Logging.scala:57) Starting executor ID driver on host dist-test-slave-5n60.c.gcp-upstream.internal
23:59:15.144 [INFO - main] (Logging.scala:57) Successfully started service 'org.apache.spark.network.netty.NettyBlockTransferService' on port 36503.
23:59:15.144 [INFO - main] (NettyBlockTransferService.scala:81) Server created on dist-test-slave-5n60.c.gcp-upstream.internal:36503
23:59:15.147 [INFO - main] (Logging.scala:57) Using org.apache.spark.storage.RandomBlockReplicationPolicy for block replication policy
23:59:15.159 [INFO - main] (Logging.scala:57) Registering BlockManager BlockManagerId(driver, dist-test-slave-5n60.c.gcp-upstream.internal, 36503, None)
23:59:15.164 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Registering block manager dist-test-slave-5n60.c.gcp-upstream.internal:36503 with 1993.9 MiB RAM, BlockManagerId(driver, dist-test-slave-5n60.c.gcp-upstream.internal, 36503, None)
23:59:15.168 [INFO - main] (Logging.scala:57) Registered BlockManager BlockManagerId(driver, dist-test-slave-5n60.c.gcp-upstream.internal, 36503, None)
23:59:15.170 [INFO - main] (Logging.scala:57) Initialized BlockManager: BlockManagerId(driver, dist-test-slave-5n60.c.gcp-upstream.internal, 36503, None)
23:59:15.419 [INFO - main] (Log.java:169) Logging initialized @8208ms to org.sparkproject.jetty.util.log.Slf4jLog
23:59:15.687 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
23:59:15.741 [DEBUG - main] (Connection.java:748) [peer master-127.28.167.253:45159(127.28.167.253:45159)] connecting to peer
23:59:15.747 [DEBUG - main] (DefaultChannelId.java:79) -Dio.netty.processId: 29330 (auto-detected)
23:59:15.749 [DEBUG - main] (NetUtil.java:148) -Djava.net.preferIPv4Stack: true
23:59:15.749 [DEBUG - main] (NetUtil.java:149) -Djava.net.preferIPv6Addresses: false
23:59:15.751 [DEBUG - main] (NetUtilInitializations.java:145) Loopback interface: lo (lo, 127.0.0.1)
23:59:15.752 [DEBUG - main] (NetUtil.java:188) /proc/sys/net/core/somaxconn: 4096
23:59:15.754 [DEBUG - main] (DefaultChannelId.java:101) -Dio.netty.machineId: 02:42:f5:ff:fe:b9:58:cc (auto-detected)
23:59:15.778 [DEBUG - main] (ByteBufUtil.java:88) -Dio.netty.allocator.type: pooled
23:59:15.779 [DEBUG - main] (ByteBufUtil.java:97) -Dio.netty.threadLocalDirectBufferSize: 0
23:59:15.779 [DEBUG - main] (ByteBufUtil.java:100) -Dio.netty.maxThreadLocalCharBufferSize: 16384
23:59:15.789 [DEBUG - main] (Connection.java:748) [peer master-127.28.167.254:33339(127.28.167.254:33339)] connecting to peer
23:59:15.791 [DEBUG - main] (Connection.java:748) [peer master-127.28.167.252:41445(127.28.167.252:41445)] connecting to peer
23:59:15.817 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.28.167.254:33339(127.28.167.254:33339)] Successfully connected to peer
23:59:15.822 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.28.167.253:45159(127.28.167.253:45159)] Successfully connected to peer
23:59:15.832 [DEBUG - kudu-nio-1] (AbstractByteBuf.java:63) -Dorg.apache.kudu.shaded.io.netty.buffer.checkAccessible: true
23:59:15.832 [DEBUG - kudu-nio-1] (AbstractByteBuf.java:64) -Dorg.apache.kudu.shaded.io.netty.buffer.checkBounds: true
23:59:15.832 [DEBUG - kudu-nio-1] (ResourceLeakDetectorFactory.java:196) Loaded default ResourceLeakDetector: org.apache.kudu.shaded.io.netty.util.ResourceLeakDetector@2198ee0b
23:59:15.838 [DEBUG - kudu-nio-1] (Recycler.java:96) -Dio.netty.recycler.maxCapacityPerThread: 4096
23:59:15.838 [DEBUG - kudu-nio-1] (Recycler.java:97) -Dio.netty.recycler.ratio: 8
23:59:15.838 [DEBUG - kudu-nio-1] (Recycler.java:98) -Dio.netty.recycler.chunkSize: 32
23:59:15.838 [DEBUG - kudu-nio-1] (Recycler.java:99) -Dio.netty.recycler.blocking: false
23:59:15.838 [DEBUG - kudu-nio-1] (Recycler.java:100) -Dio.netty.recycler.batchFastThreadLocalOnly: true
23:59:15.888 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.28.167.252:41445(127.28.167.252:41445)] Successfully connected to peer
23:59:15.923 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.28.167.254
23:59:15.923 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.28.167.253
23:59:16.180 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.28.167.252
23:59:16.181 [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
23:59:16.190 [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
23:59:16.194 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xe319d3a8, L:/127.0.0.1:38816 - R:/127.28.167.254:33339] using SASL/PLAIN
23:59:16.210 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x825495cb, L:/127.0.0.1:57984 - R:/127.28.167.253:45159] using SASL/PLAIN
23:59:16.212 [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
23:59:16.225 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x8229d722, L:/127.0.0.1:38158 - R:/127.28.167.252:41445] using SASL/PLAIN
23:59:16.256 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
23:59:16.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.314702 29385 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:38816:
23:59:16.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "test"
23:59:16.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
23:59:16.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
23:59:16.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
23:59:16.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c1_i"
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c2_s"
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c3_double"
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DOUBLE
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c4_long"
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT64
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c5_bool"
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c6_short"
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT16
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c7_float"
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: FLOAT
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c8_binary"
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BINARY
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c9_unixtime_micros"
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: UNIXTIME_MICROS
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c10_byte"
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT8
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c11_decimal32"
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL32
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 9
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c12_decimal64"
23:59:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL64
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 18
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c13_decimal128"
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL128
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 38
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c14_varchar"
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: VARCHAR
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
23:59:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       length: 65535
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c15_date"
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DATE
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) split_rows_range_bounds {
23:59:16.320 [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"
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
23:59:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) owner: "testuser"
23:59:16.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.371906 29687 tablet_service.cc:1467] Processing CreateTablet for tablet 615349ee6a714587bdbaf5e29ca1fc24 (DEFAULT_TABLE table=test [id=3910fd343f504505b15a9de18abebc48]), partition=RANGE (key) PARTITION VALUES < 50
23:59:16.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.374217 29687 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 615349ee6a714587bdbaf5e29ca1fc24. 1 dirs total, 0 dirs full, 0 dirs failed
23:59:16.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.375249 29962 tablet_service.cc:1467] Processing CreateTablet for tablet 5e335e4bd72a4437a01b4c3b32356a98 (DEFAULT_TABLE table=test [id=3910fd343f504505b15a9de18abebc48]), partition=RANGE (key) PARTITION 50 <= VALUES
23:59:16.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.377022 29962 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 5e335e4bd72a4437a01b4c3b32356a98. 1 dirs total, 0 dirs full, 0 dirs failed
23:59:16.384 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 3910fd343f504505b15a9de18abebc48
23:59:16.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.392444 30086 tablet_bootstrap.cc:492] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5: Bootstrap starting.
23:59:16.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.393456 30087 tablet_bootstrap.cc:492] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0: Bootstrap starting.
23:59:16.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.396437 30086 tablet_bootstrap.cc:654] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5: Neither blocks nor log segments found. Creating new log.
23:59:16.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.397078 30087 tablet_bootstrap.cc:654] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0: Neither blocks nor log segments found. Creating new log.
23:59:16.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.397811 30086 log.cc:824] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5: Log is configured to *not* fsync() on all Append() calls
23:59:16.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.398334 30087 log.cc:824] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0: Log is configured to *not* fsync() on all Append() calls
23:59:16.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.400890 30086 tablet_bootstrap.cc:492] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5: No bootstrap required, opened a new log
23:59:16.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.401177 30086 ts_tablet_manager.cc:1397] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5: Time spent bootstrapping tablet: real 0.009s	user 0.006s	sys 0.000s
23:59:16.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.401542 30087 tablet_bootstrap.cc:492] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0: No bootstrap required, opened a new log
23:59:16.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.401968 30087 ts_tablet_manager.cc:1397] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0: Time spent bootstrapping tablet: real 0.009s	user 0.008s	sys 0.000s
23:59:16.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.413795 30087 raft_consensus.cc:348] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "6264e5f880454946a9a7f9a76c5f99e0" member_type: VOTER last_known_addr { host: "127.28.167.193" port: 42445 } }
23:59:16.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.414191 30087 raft_consensus.cc:374] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:59:16.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.414279 30087 raft_consensus.cc:729] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6264e5f880454946a9a7f9a76c5f99e0, State: Initialized, Role: FOLLOWER
23:59:16.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.414935 30087 consensus_queue.cc:260] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [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: "6264e5f880454946a9a7f9a76c5f99e0" member_type: VOTER last_known_addr { host: "127.28.167.193" port: 42445 } }
23:59:16.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.415256 30087 raft_consensus.cc:388] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
23:59:16.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.415395 30087 raft_consensus.cc:482] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
23:59:16.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.415573 30087 raft_consensus.cc:3037] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [term 0 FOLLOWER]: Advancing to term 1
23:59:16.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.417908 30087 raft_consensus.cc:504] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "6264e5f880454946a9a7f9a76c5f99e0" member_type: VOTER last_known_addr { host: "127.28.167.193" port: 42445 } }
23:59:16.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.418468 30087 leader_election.cc:302] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [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: 6264e5f880454946a9a7f9a76c5f99e0; no voters: 
23:59:16.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.419180 30087 leader_election.cc:288] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [CANDIDATE]: Term 1 election: Requested vote from peers 
23:59:16.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.419289 30090 raft_consensus.cc:2781] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [term 1 FOLLOWER]: Leader election won for term 1
23:59:16.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.423599 30090 raft_consensus.cc:686] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [term 1 LEADER]: Becoming Leader. State: Replica: 6264e5f880454946a9a7f9a76c5f99e0, State: Running, Role: LEADER
23:59:16.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.424964 30086 raft_consensus.cc:348] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "7b38afae61a348aea641e7fbfaf1bde5" member_type: VOTER last_known_addr { host: "127.28.167.195" port: 33267 } }
23:59:16.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.425451 30086 raft_consensus.cc:374] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:59:16.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.425556 30086 raft_consensus.cc:729] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7b38afae61a348aea641e7fbfaf1bde5, State: Initialized, Role: FOLLOWER
23:59:16.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.426229 30086 consensus_queue.cc:260] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [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: "7b38afae61a348aea641e7fbfaf1bde5" member_type: VOTER last_known_addr { host: "127.28.167.195" port: 33267 } }
23:59:16.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.426525 30086 raft_consensus.cc:388] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
23:59:16.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.426681 30086 raft_consensus.cc:482] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
23:59:16.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.426874 30086 raft_consensus.cc:3037] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [term 0 FOLLOWER]: Advancing to term 1
23:59:16.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.425865 30090 consensus_queue.cc:237] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 [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: "6264e5f880454946a9a7f9a76c5f99e0" member_type: VOTER last_known_addr { host: "127.28.167.193" port: 42445 } }
23:59:16.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.430433 30086 raft_consensus.cc:504] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "7b38afae61a348aea641e7fbfaf1bde5" member_type: VOTER last_known_addr { host: "127.28.167.195" port: 33267 } }
23:59:16.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.431090 30086 leader_election.cc:302] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [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: 7b38afae61a348aea641e7fbfaf1bde5; no voters: 
23:59:16.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.434561 30087 ts_tablet_manager.cc:1428] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0: Time spent starting tablet: real 0.032s	user 0.022s	sys 0.008s
23:59:16.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.436390 30086 leader_election.cc:288] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [CANDIDATE]: Term 1 election: Requested vote from peers 
23:59:16.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.436635 30094 raft_consensus.cc:2781] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [term 1 FOLLOWER]: Leader election won for term 1
23:59:16.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.441478 30094 raft_consensus.cc:686] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [term 1 LEADER]: Becoming Leader. State: Replica: 7b38afae61a348aea641e7fbfaf1bde5, State: Running, Role: LEADER
23:59:16.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.445024 30086 ts_tablet_manager.cc:1428] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5: Time spent starting tablet: real 0.044s	user 0.020s	sys 0.012s
23:59:16.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.445722 30094 consensus_queue.cc:237] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 [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: "7b38afae61a348aea641e7fbfaf1bde5" member_type: VOTER last_known_addr { host: "127.28.167.195" port: 33267 } }
23:59:16.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.448499 29385 catalog_manager.cc:5495] T 615349ee6a714587bdbaf5e29ca1fc24 P 6264e5f880454946a9a7f9a76c5f99e0 reported cstate change: term changed from 0 to 1, leader changed from <none> to 6264e5f880454946a9a7f9a76c5f99e0 (127.28.167.193). New cstate: current_term: 1 leader_uuid: "6264e5f880454946a9a7f9a76c5f99e0" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "6264e5f880454946a9a7f9a76c5f99e0" member_type: VOTER last_known_addr { host: "127.28.167.193" port: 42445 } health_report { overall_health: HEALTHY } } }
23:59:16.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.452843 29384 catalog_manager.cc:5495] T 5e335e4bd72a4437a01b4c3b32356a98 P 7b38afae61a348aea641e7fbfaf1bde5 reported cstate change: term changed from 0 to 1, leader changed from <none> to 7b38afae61a348aea641e7fbfaf1bde5 (127.28.167.195). New cstate: current_term: 1 leader_uuid: "7b38afae61a348aea641e7fbfaf1bde5" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "7b38afae61a348aea641e7fbfaf1bde5" member_type: VOTER last_known_addr { host: "127.28.167.195" port: 33267 } health_report { overall_health: HEALTHY } } }
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.491036 29383 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:38816:
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "simple-test"
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:59:16.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "val"
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:59:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
23:59:16.506 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 87e9b6621882454e8735cd150e615ef3
23:59:16.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.518421 29827 tablet_service.cc:1467] Processing CreateTablet for tablet 41472f7c30f6412ba1a15a73d6e82272 (DEFAULT_TABLE table=simple-test [id=87e9b6621882454e8735cd150e615ef3]), partition=RANGE (key) PARTITION UNBOUNDED
23:59:16.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.519600 29827 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 41472f7c30f6412ba1a15a73d6e82272. 1 dirs total, 0 dirs full, 0 dirs failed
23:59:16.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.531068 30101 tablet_bootstrap.cc:492] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b: Bootstrap starting.
23:59:16.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.534118 30101 tablet_bootstrap.cc:654] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b: Neither blocks nor log segments found. Creating new log.
23:59:16.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.535063 30101 log.cc:824] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b: Log is configured to *not* fsync() on all Append() calls
23:59:16.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.537822 30101 tablet_bootstrap.cc:492] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b: No bootstrap required, opened a new log
23:59:16.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.538048 30101 ts_tablet_manager.cc:1397] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b: Time spent bootstrapping tablet: real 0.007s	user 0.002s	sys 0.004s
23:59:16.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.545722 30101 raft_consensus.cc:348] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "0320b0f656654782ad9ec54cef621a9b" member_type: VOTER last_known_addr { host: "127.28.167.194" port: 33971 } }
23:59:16.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.546346 30101 raft_consensus.cc:374] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:59:16.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.546566 30101 raft_consensus.cc:729] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 0320b0f656654782ad9ec54cef621a9b, State: Initialized, Role: FOLLOWER
23:59:16.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.547251 30101 consensus_queue.cc:260] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [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: "0320b0f656654782ad9ec54cef621a9b" member_type: VOTER last_known_addr { host: "127.28.167.194" port: 33971 } }
23:59:16.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.547526 30101 raft_consensus.cc:388] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
23:59:16.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.547667 30101 raft_consensus.cc:482] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
23:59:16.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.547883 30101 raft_consensus.cc:3037] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [term 0 FOLLOWER]: Advancing to term 1
23:59:16.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.550868 30101 raft_consensus.cc:504] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "0320b0f656654782ad9ec54cef621a9b" member_type: VOTER last_known_addr { host: "127.28.167.194" port: 33971 } }
23:59:16.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.551424 30101 leader_election.cc:302] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [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: 0320b0f656654782ad9ec54cef621a9b; no voters: 
23:59:16.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.552160 30101 leader_election.cc:288] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [CANDIDATE]: Term 1 election: Requested vote from peers 
23:59:16.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.552295 30103 raft_consensus.cc:2781] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [term 1 FOLLOWER]: Leader election won for term 1
23:59:16.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.554353 30101 ts_tablet_manager.cc:1428] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b: Time spent starting tablet: real 0.016s	user 0.015s	sys 0.000s
23:59:16.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.555115 30103 raft_consensus.cc:686] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [term 1 LEADER]: Becoming Leader. State: Replica: 0320b0f656654782ad9ec54cef621a9b, State: Running, Role: LEADER
23:59:16.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.555630 30103 consensus_queue.cc:237] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b [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: "0320b0f656654782ad9ec54cef621a9b" member_type: VOTER last_known_addr { host: "127.28.167.194" port: 33971 } }
23:59:16.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:16.562001 29383 catalog_manager.cc:5495] T 41472f7c30f6412ba1a15a73d6e82272 P 0320b0f656654782ad9ec54cef621a9b reported cstate change: term changed from 0 to 1, leader changed from <none> to 0320b0f656654782ad9ec54cef621a9b (127.28.167.194). New cstate: current_term: 1 leader_uuid: "0320b0f656654782ad9ec54cef621a9b" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "0320b0f656654782ad9ec54cef621a9b" member_type: VOTER last_known_addr { host: "127.28.167.194" port: 33971 } health_report { overall_health: HEALTHY } } }
23:59:18.254 [INFO - main] (Logging.scala:57) Setting hive.metastore.warehouse.dir ('null') to the value of spark.sql.warehouse.dir ('file:/tmp/dist-test-taskOhPADJ/java/build/dist-test/spark-warehouse').
23:59:18.254 [INFO - main] (Logging.scala:57) Warehouse path is 'file:/tmp/dist-test-taskOhPADJ/java/build/dist-test/spark-warehouse'.
23:59:19.714 [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.
23:59:19.847 [INFO - main] (Logging.scala:57) Checkpoint root /tmp/spark_kudu228633565344260034 resolved to file:/tmp/spark_kudu228633565344260034.
23:59:19.920 [INFO - main] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu228633565344260034/metadata using temp file file:/tmp/spark_kudu228633565344260034/.metadata.ad9ae877-63b6-4708-abe1-e955b617186c.tmp
23:59:20.052 [INFO - main] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu228633565344260034/.metadata.ad9ae877-63b6-4708-abe1-e955b617186c.tmp to file:/tmp/spark_kudu228633565344260034/metadata
23:59:20.111 [INFO - main] (Logging.scala:57) Starting [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]. Use file:/tmp/spark_kudu228633565344260034 to store the query checkpoint.
23:59:20.154 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Reading table [org.apache.spark.sql.execution.streaming.MemoryStreamTable@6ae1f680] from DataSourceV2 named 'memory' [org.apache.spark.sql.execution.streaming.MemoryStreamTableProvider$@41b19fb0]
23:59:20.182 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Starting new streaming query.
23:59:20.186 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Stream started from {}
23:59:20.260 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Streaming query made progress: {
  "id" : "74e660ca-1abe-42d5-8d2c-fe497bd4068d",
  "runId" : "feb7cabe-8741-4132-b6df-e46d36d1c2e4",
  "name" : null,
  "timestamp" : "2026-07-07T23:59:20.178Z",
  "batchId" : 0,
  "numInputRows" : 0,
  "inputRowsPerSecond" : 0.0,
  "processedRowsPerSecond" : 0.0,
  "durationMs" : {
    "latestOffset" : 0,
    "triggerExecution" : 18
  },
  "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@5352ac3c",
    "numOutputRows" : -1
  }
}
23:59:20.544 [INFO - main] (Logging.scala:57) Code generated in 235.23519 ms
23:59:20.576 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu228633565344260034/offsets/0 using temp file file:/tmp/spark_kudu228633565344260034/offsets/.0.59c1d47f-5019-4177-b3b1-64317d052a8c.tmp
23:59:20.625 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu228633565344260034/offsets/.0.59c1d47f-5019-4177-b3b1-64317d052a8c.tmp to file:/tmp/spark_kudu228633565344260034/offsets/0
23:59:20.626 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Committed offsets for batch 0. Metadata OffsetSeqMetadata(0,1783468760554,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))
23:59:21.644 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Code generated in 52.181712 ms
23:59:21.854 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Starting job: start at StreamingTest.scala:54
23:59:21.877 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Got job 0 (start at StreamingTest.scala:54) with 1 output partitions
23:59:21.878 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Final stage: ResultStage 0 (start at StreamingTest.scala:54)
23:59:21.878 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Parents of final stage: List()
23:59:21.881 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Missing parents: List()
23:59:21.889 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting ResultStage 0 (MapPartitionsRDD[4] at start at StreamingTest.scala:54), which has no missing parents
23:59:21.992 [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)
23:59:22.034 [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)
23:59:22.037 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Added broadcast_0_piece0 in memory on dist-test-slave-5n60.c.gcp-upstream.internal:36503 (size: 7.8 KiB, free: 1993.9 MiB)
23:59:22.040 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Created broadcast 0 from broadcast at DAGScheduler.scala:1388
23:59:22.056 [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))
23:59:22.057 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Adding task set 0.0 with 1 tasks resource profile 0
23:59:22.121 [INFO - dispatcher-event-loop-1] (Logging.scala:57) Starting task 0.0 in stage 0.0 (TID 0) (dist-test-slave-5n60.c.gcp-upstream.internal, executor driver, partition 0, PROCESS_LOCAL, 4803 bytes) taskResourceAssignments Map()
23:59:22.141 [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)
23:59:22.581 [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
23:59:22.585 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 87e9b6621882454e8735cd150e615ef3
23:59:22.592 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 87e9b6621882454e8735cd150e615ef3
23:59:22.599 [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'
23:59:22.618 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 41472f7c30f6412ba1a15a73d6e82272 for table 'simple-test' with partition [<start>, <end>)
23:59:22.619 [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@57e0e041, flushNotification=Deferred@476092228(state=PENDING, result=null, callback=<none>, errback=<none>)}
23:59:22.618 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299991, tablet=41472f7c30f6412ba1a15a73d6e82272@[0320b0f656654782ad9ec54cef621a9b(127.28.167.194:33971)[L]]}]
23:59:22.633 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 41472f7c30f6412ba1a15a73d6e82272 for table 'simple-test' with partition [<start>, <end>)
23:59:22.634 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=41472f7c30f6412ba1a15a73d6e82272@[0320b0f656654782ad9ec54cef621a9b(127.28.167.194:33971)[L]]}]
23:59:22.635 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 41472f7c30f6412ba1a15a73d6e82272 for table 'simple-test' with partition [<start>, <end>)
23:59:22.635 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=41472f7c30f6412ba1a15a73d6e82272@[0320b0f656654782ad9ec54cef621a9b(127.28.167.194:33971)[L]]}]
23:59:22.649 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 0320b0f656654782ad9ec54cef621a9b(127.28.167.194:33971)] connecting to peer
23:59:22.652 [DEBUG - kudu-nio-1] (Connection.java:757) [peer 0320b0f656654782ad9ec54cef621a9b(127.28.167.194:33971)] Successfully connected to peer
23:59:22.700 [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
23:59:22.704 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xd43b273c, L:/127.0.0.1:49948 - R:/127.28.167.194:33971] using TOKEN/null
23:59:22.748 [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 144ms
23:59:22.772 [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). 6759 bytes result sent to driver
23:59:22.786 [INFO - task-result-getter-0] (Logging.scala:57) Finished task 0.0 in stage 0.0 (TID 0) in 678 ms on dist-test-slave-5n60.c.gcp-upstream.internal (executor driver) (1/1)
23:59:22.789 [INFO - task-result-getter-0] (Logging.scala:57) Removed TaskSet 0.0, whose tasks have all completed, from pool 
23:59:22.799 [INFO - dag-scheduler-event-loop] (Logging.scala:57) ResultStage 0 (start at StreamingTest.scala:54) finished in 0.894 s
23:59:22.820 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Job 0 is finished. Cancelling potential speculative or zombie tasks for this job
23:59:22.820 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Killing all running tasks in stage 0: Stage finished
23:59:22.823 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Job 0 finished: start at StreamingTest.scala:54, took 0.968931 s
23:59:22.827 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (KuduContext.scala:445) completed upsert ops: duration histogram: 144ms
23:59:22.849 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu228633565344260034/commits/0 using temp file file:/tmp/spark_kudu228633565344260034/commits/.0.df8b81fa-10cf-4cb7-b132-ebd64ab9e8a6.tmp
23:59:22.871 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu228633565344260034/commits/.0.df8b81fa-10cf-4cb7-b132-ebd64ab9e8a6.tmp to file:/tmp/spark_kudu228633565344260034/commits/0
23:59:22.888 [INFO - stream execution thread for [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4]] (Logging.scala:57) Streaming query made progress: {
  "id" : "74e660ca-1abe-42d5-8d2c-fe497bd4068d",
  "runId" : "feb7cabe-8741-4132-b6df-e46d36d1c2e4",
  "name" : null,
  "timestamp" : "2026-07-07T23:59:20.553Z",
  "batchId" : 0,
  "numInputRows" : 3,
  "inputRowsPerSecond" : 272.72727272727275,
  "processedRowsPerSecond" : 1.29366106080207,
  "durationMs" : {
    "addBatch" : 1646,
    "getBatch" : 3,
    "latestOffset" : 0,
    "queryPlanning" : 550,
    "triggerExecution" : 2319,
    "walCommit" : 70
  },
  "stateOperators" : [ ],
  "sources" : [ {
    "description" : "MemoryStream[value#1]",
    "startOffset" : null,
    "endOffset" : 0,
    "numInputRows" : 3,
    "inputRowsPerSecond" : 272.72727272727275,
    "processedRowsPerSecond" : 1.29366106080207
  } ],
  "sink" : {
    "description" : "org.apache.kudu.spark.kudu.KuduSink@5352ac3c",
    "numOutputRows" : -1
  }
}
23:59:22.904 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 87e9b6621882454e8735cd150e615ef3
23:59:23.001 [INFO - main] (Logging.scala:57) Code generated in 11.36154 ms
23:59:23.106 [INFO - main] (Logging.scala:57) Starting job: collect at StreamingTest.scala:60
23:59:23.107 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Got job 1 (collect at StreamingTest.scala:60) with 1 output partitions
23:59:23.108 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Final stage: ResultStage 1 (collect at StreamingTest.scala:60)
23:59:23.108 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Parents of final stage: List()
23:59:23.108 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Missing parents: List()
23:59:23.110 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting ResultStage 1 (MapPartitionsRDD[11] at map at StreamingTest.scala:60), which has no missing parents
23:59:23.120 [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)
23:59:23.123 [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)
23:59:23.124 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Added broadcast_1_piece0 in memory on dist-test-slave-5n60.c.gcp-upstream.internal:36503 (size: 9.1 KiB, free: 1993.9 MiB)
23:59:23.125 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Created broadcast 1 from broadcast at DAGScheduler.scala:1388
23:59:23.126 [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))
23:59:23.126 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Adding task set 1.0 with 1 tasks resource profile 0
23:59:23.132 [INFO - dispatcher-event-loop-0] (Logging.scala:57) Starting task 0.0 in stage 1.0 (TID 1) (dist-test-slave-5n60.c.gcp-upstream.internal, executor driver, partition 0, ANY, 4800 bytes) taskResourceAssignments Map()
23:59:23.133 [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)
23:59:23.238 [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
23:59:23.275 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Code generated in 10.355603 ms
23:59:23.327 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305088054503448576) for scanner KuduScanner(table=simple-test, tablet=41472f7c30f6412ba1a15a73d6e82272, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:59:23.383 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Code generated in 36.215169 ms
23:59:23.406 [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). 5376 bytes result sent to driver
23:59:23.412 [INFO - task-result-getter-1] (Logging.scala:57) Finished task 0.0 in stage 1.0 (TID 1) in 280 ms on dist-test-slave-5n60.c.gcp-upstream.internal (executor driver) (1/1)
23:59:23.412 [INFO - task-result-getter-1] (Logging.scala:57) Removed TaskSet 1.0, whose tasks have all completed, from pool 
23:59:23.413 [INFO - dag-scheduler-event-loop] (Logging.scala:57) ResultStage 1 (collect at StreamingTest.scala:60) finished in 0.298 s
23:59:23.413 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Job 1 is finished. Cancelling potential speculative or zombie tasks for this job
23:59:23.414 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Killing all running tasks in stage 1: Stage finished
23:59:23.414 [INFO - main] (Logging.scala:57) Job 1 finished: collect at StreamingTest.scala:60, took 0.307928 s
23:59:23.418 [INFO - main] (Logging.scala:57) Asked to cancel job group feb7cabe-8741-4132-b6df-e46d36d1c2e4
23:59:23.435 [INFO - main] (Logging.scala:57) Asked to cancel job group feb7cabe-8741-4132-b6df-e46d36d1c2e4
23:59:23.436 [INFO - main] (Logging.scala:57) Query [id = 74e660ca-1abe-42d5-8d2c-fe497bd4068d, runId = feb7cabe-8741-4132-b6df-e46d36d1c2e4] was stopped
23:59:23.468 [INFO - dispatcher-event-loop-0] (Logging.scala:57) MapOutputTrackerMasterEndpoint stopped!
23:59:23.498 [INFO - main] (Logging.scala:57) MemoryStore cleared
23:59:23.499 [INFO - main] (Logging.scala:57) BlockManager stopped
23:59:23.511 [INFO - main] (Logging.scala:57) BlockManagerMaster stopped
23:59:23.515 [INFO - dispatcher-event-loop-0] (Logging.scala:57) OutputCommitCoordinator stopped!
23:59:23.522 [INFO - main] (Logging.scala:57) Successfully stopped SparkContext
23:59:23.526 [DEBUG - main] (Connection.java:575) [peer master-127.28.167.254:33339(127.28.167.254:33339)] disconnecting while in state READY
23:59:23.528 [DEBUG - main] (Connection.java:575) [peer 0320b0f656654782ad9ec54cef621a9b(127.28.167.194:33971)] disconnecting while in state READY
23:59:23.528 [DEBUG - main] (Connection.java:575) [peer master-127.28.167.253:45159(127.28.167.253:45159)] disconnecting while in state READY
23:59:23.534 [DEBUG - main] (Connection.java:575) [peer master-127.28.167.252:41445(127.28.167.252:41445)] disconnecting while in state READY
23:59:23.535 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.28.167.253:45159(127.28.167.253:45159)] handling channelInactive
23:59:23.536 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.28.167.253:45159(127.28.167.253:45159)] cleaning up while in state READY due to: connection closed
23:59:23.542 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.28.167.252:41445(127.28.167.252:41445)] handling channelInactive
23:59:23.542 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
23:59:23.542 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.28.167.252:41445(127.28.167.252:41445)] cleaning up while in state READY due to: connection closed
23:59:23.544 [DEBUG - kudu-nio-0] (PoolThreadCache.java:221) Freed 20 thread-local buffer(s) from thread: kudu-nio-0
23:59:23.545 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.28.167.254:33339(127.28.167.254:33339)] handling channelInactive
23:59:23.545 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.28.167.254:33339(127.28.167.254:33339)] cleaning up while in state READY due to: connection closed
23:59:23.547 [DEBUG - kudu-nio-1] (Connection.java:239) [peer 0320b0f656654782ad9ec54cef621a9b(127.28.167.194:33971)] handling channelInactive
23:59:23.547 [DEBUG - kudu-nio-1] (Connection.java:709) [peer 0320b0f656654782ad9ec54cef621a9b(127.28.167.194:33971)] cleaning up while in state READY due to: connection closed
23:59:23.548 [DEBUG - kudu-nio-1] (PoolThreadCache.java:221) Freed 31 thread-local buffer(s) from thread: kudu-nio-1
23:59:23.562 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
23:59:23.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:23.563997 29343 external_mini_cluster.cc:1636] Attempting to check leaks for /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu pid 29625
23:59:23.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:23.590605 29747 generic_service.cc:196] Checking for leaks (request via RPC)
23:59:23.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:23.693328 29343 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu with pid 29625
23:59:23.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:23.710654 29343 external_mini_cluster.cc:1636] Attempting to check leaks for /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu pid 29762
23:59:23.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:23.719731 29887 generic_service.cc:196] Checking for leaks (request via RPC)
23:59:23.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:23.844879 29343 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu with pid 29762
23:59:23.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:23.866339 29343 external_mini_cluster.cc:1636] Attempting to check leaks for /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu pid 29898
23:59:23.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:23.873541 30022 generic_service.cc:196] Checking for leaks (request via RPC)
23:59:23.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:23.963435 29343 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu with pid 29898
23:59:23.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:23.980448 29343 external_mini_cluster.cc:1636] Attempting to check leaks for /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu pid 29354
23:59:23.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:23.981783 29415 generic_service.cc:196] Checking for leaks (request via RPC)
23:59:24.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:24.094496 29343 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu with pid 29354
23:59:24.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:24.115347 29343 external_mini_cluster.cc:1636] Attempting to check leaks for /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu pid 29422
23:59:24.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:24.116389 29486 generic_service.cc:196] Checking for leaks (request via RPC)
23:59:24.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:24.222112 29343 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu with pid 29422
23:59:24.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:24.241864 29343 external_mini_cluster.cc:1636] Attempting to check leaks for /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu pid 29493
23:59:24.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:24.242882 29557 generic_service.cc:196] Checking for leaks (request via RPC)
23:59:24.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:59:24.350070 29343 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskOhPADJ/build/asan/bin/kudu with pid 29493
23:59:24.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:59:24Z chronyd exiting

Time: 16.83

OK (1 test)

23:59:24.750 [INFO - shutdown-hook-0] (Logging.scala:57) Shutdown hook called
23:59:24.751 [INFO - shutdown-hook-0] (Logging.scala:57) Deleting directory /tmp/spark-6d114145-99af-4acc-8026-34d349e112e6
