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

16:04:41.594 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
16:04:41.602 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

16:04:41.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.604144 11446 mini_oidc.cc:152] Starting JWKS server
16:04:41.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.605566 11446 webserver.cc:460] Webserver started at http://127.0.0.1:45125/ using document root <none> and password file <none>
16:04:41.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.605677 11446 mini_oidc.cc:189] Starting OIDC Discovery server
16:04:41.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.605917 11446 webserver.cc:460] Webserver started at http://127.0.0.1:39711/ using document root <none> and password file <none>
16:04:41.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T16:04:41Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
16:04:41.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T16:04:41Z Disabled control of system clock
16:04:41.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.621853 11446 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:41.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/wal
16:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/data
16:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/logs
16:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/data/info.pb
16:04:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:41.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:04:41.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:04:41.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:04:41.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:04:41.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:41.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:41.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:41.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:04:41.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:04:41.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:04:41.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:04:41.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.190:42895
16:04:41.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.190
16:04:41.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:41.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:41.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:41.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:41.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:04:41.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:04:41.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:41.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:04:41.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45125/jwks.json with env {}
16:04:41.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.733593 11457 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:04:41.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.733841 11457 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:04:41.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.733865 11457 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:04:41.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.735176 11457 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:04:41.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.735224 11457 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:04:41.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.735237 11457 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:04:41.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.735249 11457 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:04:41.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.735262 11457 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:04:41.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.735273 11457 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45125/jwks.json
16:04:41.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.736722 11457 master_runner.cc:386] Master server non-default flags:
16:04:41.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:41.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:41.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:41.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:04:41.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/data
16:04:41.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/wal
16:04:41.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:04:41.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:41.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:41.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:41.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:04:41.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.190:42895
16:04:41.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:04:41.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:04:41.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:04:41.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45125/jwks.json
16:04:41.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:41.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:41.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/data/info.pb
16:04:41.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.190
16:04:41.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:41.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:04:41.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.11457
16:04:41.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:41.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:04:41.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:04:41.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:41.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/logs
16:04:41.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:41.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:04:41.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:04:41.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:04:41.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:04:41.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:04:41.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
16:04:41.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 14:54:46 UTC on ccycloud.quasar-lejogm.root.comops.site
16:04:41.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493842
16:04:41.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.737023 11457 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:04:41.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.737535 11457 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:04:41.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.743788 11463 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
16:04:41.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.743932 11462 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
16:04:41.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.744182 11457 server_base.cc:1034] running on GCE node
16:04:41.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.743844 11465 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
16:04:41.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.744894 11457 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:04:41.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.745321 11457 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:04:41.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.746469 11457 hybrid_clock.cc:648] HybridClock initialized: now 1783526681746444 us; error 48 us; skew 500 ppm
16:04:41.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.748348 11457 webserver.cc:460] Webserver started at http://127.11.45.190:42435/ using document root <none> and password file <none>
16:04:41.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.748601 11457 fs_manager.cc:359] Metadata directory not provided
16:04:41.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.748642 11457 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:04:41.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.748777 11457 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:04:41.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.750404 11457 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/data/instance:
16:04:41.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ff17621c3b0a4836bde7b6e4eeb82055"
16:04:41.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:41 on dist-test-slave-2v85"
16:04:41.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.750809 11457 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/wal/instance:
16:04:41.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ff17621c3b0a4836bde7b6e4eeb82055"
16:04:41.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:41 on dist-test-slave-2v85"
16:04:41.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.752533 11457 fs_manager.cc:691] Time spent creating directory manager: real 0.002s	user 0.002s	sys 0.000s
16:04:41.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.753542 11471 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:04:41.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.753779 11457 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
16:04:41.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.753868 11457 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/data,/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/wal
16:04:41.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ff17621c3b0a4836bde7b6e4eeb82055"
16:04:41.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:41 on dist-test-slave-2v85"
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.753923 11457 fs_report.cc:383] FS layout report
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/wal
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/wal
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/data/data
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:04:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:04:41.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:04:41.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:04:41.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:04:41.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:04:41.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.776019 11457 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:04:41.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.776544 11457 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
16:04:41.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.776697 11457 kserver.cc:163] Server-wide thread pool size limit: 3276
16:04:41.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.785015 11457 rpc_server.cc:307] RPC server started. Bound to: 127.11.45.190:42895
16:04:41.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.785178 11523 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.11.45.190:42895 every 8 connection(s)
16:04:41.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.785501 11457 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/data/info.pb
16:04:41.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.786593 11524 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
16:04:41.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.788133 11446 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskGYRXSD/build/release/bin/kudu as pid 11457
16:04:41.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.788285 11446 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-0/wal/instance
16:04:41.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.789083 11524 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } has no permanent_uuid. Determining permanent_uuid...
16:04:41.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.789399 11446 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:41.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:41.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/wal
16:04:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/data
16:04:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:04:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:04:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:04:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/logs
16:04:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/data/info.pb
16:04:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:04:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:04:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:04:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:04:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:04:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:04:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:04:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:04:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.189:33751
16:04:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.189
16:04:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:04:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:04:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:41.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:04:41.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45125/jwks.json with env {}
16:04:41.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.798640 11524 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } has no permanent_uuid. Determining permanent_uuid...
16:04:41.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.799309 11474 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.11.45.189:33751: connect: Connection refused (error 111)
16:04:41.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.799999 11524 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.11.45.189:33751: Network error: Client connection negotiation failed: client connection to 127.11.45.189:33751: connect: Connection refused (error 111)
16:04:41.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.849314 11524 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } attempt: 1
16:04:41.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.850564 11524 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.11.45.189:33751: Network error: Client connection negotiation failed: client connection to 127.11.45.189:33751: connect: Connection refused (error 111)
16:04:41.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.905987 11528 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:04:41.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.906359 11528 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:04:41.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.906383 11528 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:04:41.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.907655 11528 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:04:41.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.907698 11528 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:04:41.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.907713 11528 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:04:41.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.907725 11528 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:04:41.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.907738 11528 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:04:41.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.907750 11528 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45125/jwks.json
16:04:41.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.909211 11528 master_runner.cc:386] Master server non-default flags:
16:04:41.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:41.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:41.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:41.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:04:41.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/data
16:04:41.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/wal
16:04:41.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:04:41.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:41.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:41.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:41.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:04:41.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.189:33751
16:04:41.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:04:41.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:04:41.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:04:41.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45125/jwks.json
16:04:41.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:41.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:41.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/data/info.pb
16:04:41.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.189
16:04:41.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:41.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:04:41.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.11528
16:04:41.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:41.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:04:41.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:04:41.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:41.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/logs
16:04:41.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:41.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:04:41.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:04:41.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:04:41.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:04:41.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:04:41.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
16:04:41.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 14:54:46 UTC on ccycloud.quasar-lejogm.root.comops.site
16:04:41.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493842
16:04:41.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.909456 11528 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:04:41.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.909775 11528 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:04:41.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.916209 11535 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
16:04:41.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.916173 11534 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
16:04:41.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.916421 11537 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
16:04:41.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.916673 11528 server_base.cc:1034] running on GCE node
16:04:41.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.917168 11528 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:04:41.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.917531 11528 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:04:41.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.918704 11528 hybrid_clock.cc:648] HybridClock initialized: now 1783526681918680 us; error 53 us; skew 500 ppm
16:04:41.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.919188 11524 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } attempt: 2
16:04:41.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.920075 11524 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.11.45.189:33751: Network error: Client connection negotiation failed: client connection to 127.11.45.189:33751: connect: Connection refused (error 111)
16:04:41.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.921075 11528 webserver.cc:460] Webserver started at http://127.11.45.189:43667/ using document root <none> and password file <none>
16:04:41.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.921420 11528 fs_manager.cc:359] Metadata directory not provided
16:04:41.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.921501 11528 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:04:41.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.921666 11528 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:04:41.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.922921 11528 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/data/instance:
16:04:41.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "31e609614ce44bc3a3c2d4d690c35376"
16:04:41.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:41 on dist-test-slave-2v85"
16:04:41.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.923317 11528 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/wal/instance:
16:04:41.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "31e609614ce44bc3a3c2d4d690c35376"
16:04:41.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:41 on dist-test-slave-2v85"
16:04:41.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.925482 11528 fs_manager.cc:691] Time spent creating directory manager: real 0.002s	user 0.000s	sys 0.003s
16:04:41.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.926570 11543 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:04:41.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.926817 11528 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.000s
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.926918 11528 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/data,/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/wal
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "31e609614ce44bc3a3c2d4d690c35376"
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:41 on dist-test-slave-2v85"
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.926990 11528 fs_report.cc:383] FS layout report
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/wal
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/wal
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/data/data
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:04:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:04:41.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:04:41.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:04:41.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:04:41.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:04:41.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:04:41.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.945709 11528 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:04:41.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.946322 11528 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
16:04:41.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.946470 11528 kserver.cc:163] Server-wide thread pool size limit: 3276
16:04:41.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.954540 11528 rpc_server.cc:307] RPC server started. Bound to: 127.11.45.189:33751
16:04:41.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.954674 11595 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.11.45.189:33751 every 8 connection(s)
16:04:41.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.954970 11528 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/data/info.pb
16:04:41.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.955933 11596 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
16:04:41.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.957147 11446 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskGYRXSD/build/release/bin/kudu as pid 11528
16:04:41.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.957228 11446 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-1/wal/instance
16:04:41.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.957612 11446 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:41.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:41.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/wal
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/data
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/logs
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/data/info.pb
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:04:41.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.188:35349
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.188
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:04:41.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:04:41.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:41.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:04:41.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45125/jwks.json with env {}
16:04:41.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.959069 11596 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } has no permanent_uuid. Determining permanent_uuid...
16:04:41.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.966310 11596 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } has no permanent_uuid. Determining permanent_uuid...
16:04:41.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:41.974545 11596 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } has no permanent_uuid. Determining permanent_uuid...
16:04:41.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.975085 11545 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.11.45.188:35349: connect: Connection refused (error 111)
16:04:41.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:41.980659 11596 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.11.45.188:35349: Network error: Client connection negotiation failed: client connection to 127.11.45.188:35349: connect: Connection refused (error 111)
16:04:42.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.011276 11524 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } attempt: 3
16:04:42.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.015760 11524 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } has no permanent_uuid. Determining permanent_uuid...
16:04:42.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.016665 11524 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.11.45.188:35349: Network error: Client connection negotiation failed: client connection to 127.11.45.188:35349: connect: Connection refused (error 111)
16:04:42.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.029937 11596 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } attempt: 1
16:04:42.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.031013 11596 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.11.45.188:35349: Network error: Client connection negotiation failed: client connection to 127.11.45.188:35349: connect: Connection refused (error 111)
16:04:42.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.047860 11524 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } attempt: 1
16:04:42.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.049238 11524 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.11.45.188:35349: Network error: Client connection negotiation failed: client connection to 127.11.45.188:35349: connect: Connection refused (error 111)
16:04:42.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.081033 11598 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:04:42.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.081305 11598 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:04:42.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.081328 11598 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:04:42.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.082583 11598 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:04:42.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.082616 11598 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:04:42.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.082629 11598 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:04:42.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.082643 11598 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:04:42.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.082655 11598 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:04:42.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.082667 11598 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45125/jwks.json
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.084013 11598 master_runner.cc:386] Master server non-default flags:
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/data
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/wal
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.188:35349
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:04:42.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45125/jwks.json
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/data/info.pb
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.188
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.11598
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/logs
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:04:42.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:04:42.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:04:42.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:04:42.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:04:42.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
16:04:42.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 14:54:46 UTC on ccycloud.quasar-lejogm.root.comops.site
16:04:42.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493842
16:04:42.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.084299 11598 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:04:42.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.084667 11598 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:04:42.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.091492 11607 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
16:04:42.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.091492 11609 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
16:04:42.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.091569 11606 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
16:04:42.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.091923 11598 server_base.cc:1034] running on GCE node
16:04:42.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.092265 11598 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:04:42.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.092639 11598 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:04:42.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.099203 11596 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } attempt: 2
16:04:42.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.100034 11598 hybrid_clock.cc:648] HybridClock initialized: now 1783526682099998 us; error 63 us; skew 500 ppm
16:04:42.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.100207 11596 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.11.45.188:35349: Network error: Client connection negotiation failed: client connection to 127.11.45.188:35349: connect: Connection refused (error 111)
16:04:42.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.102365 11598 webserver.cc:460] Webserver started at http://127.11.45.188:35101/ using document root <none> and password file <none>
16:04:42.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.102710 11598 fs_manager.cc:359] Metadata directory not provided
16:04:42.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.102792 11598 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:04:42.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.102952 11598 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:04:42.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.104624 11598 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/data/instance:
16:04:42.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7178e3a7fff1457ea7f68acccc835bc7"
16:04:42.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:42 on dist-test-slave-2v85"
16:04:42.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.105592 11598 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/wal/instance:
16:04:42.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7178e3a7fff1457ea7f68acccc835bc7"
16:04:42.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:42 on dist-test-slave-2v85"
16:04:42.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.107528 11598 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.001s
16:04:42.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.108553 11615 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:04:42.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.108749 11598 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
16:04:42.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.108853 11598 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/data,/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/wal
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7178e3a7fff1457ea7f68acccc835bc7"
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:42 on dist-test-slave-2v85"
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.108939 11598 fs_report.cc:383] FS layout report
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/wal
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/wal
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/data/data
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:04:42.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:04:42.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:04:42.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:04:42.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:04:42.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.124449 11524 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } attempt: 2
16:04:42.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.125507 11524 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.11.45.188:35349: Network error: Client connection negotiation failed: client connection to 127.11.45.188:35349: connect: Connection refused (error 111)
16:04:42.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.140779 11598 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:04:42.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.141312 11598 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
16:04:42.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.141470 11598 kserver.cc:163] Server-wide thread pool size limit: 3276
16:04:42.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.150215 11598 rpc_server.cc:307] RPC server started. Bound to: 127.11.45.188:35349
16:04:42.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.150275 11667 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.11.45.188:35349 every 8 connection(s)
16:04:42.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.150766 11598 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/data/info.pb
16:04:42.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.151836 11668 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
16:04:42.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.154649 11668 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } has no permanent_uuid. Determining permanent_uuid...
16:04:42.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.155845 11446 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskGYRXSD/build/release/bin/kudu as pid 11598
16:04:42.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.155970 11446 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/master-2/wal/instance
16:04:42.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.162576 11668 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } has no permanent_uuid. Determining permanent_uuid...
16:04:42.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.167369 11668 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } has no permanent_uuid. Determining permanent_uuid...
16:04:42.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.173735 11668 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7: Bootstrap starting.
16:04:42.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.175020 11668 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7: Neither blocks nor log segments found. Creating new log.
16:04:42.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.175779 11668 log.cc:824] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7: Log is configured to *not* fsync() on all Append() calls
16:04:42.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.176803 11668 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7: No bootstrap required, opened a new log
16:04:42.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.180570 11668 raft_consensus.cc:348] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } }
16:04:42.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.180732 11668 raft_consensus.cc:374] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:04:42.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.180757 11668 raft_consensus.cc:729] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7178e3a7fff1457ea7f68acccc835bc7, State: Initialized, Role: FOLLOWER
16:04:42.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.180909 11668 consensus_queue.cc:260] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [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: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } }
16:04:42.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.181403 11668 sys_catalog.cc:564] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [sys.catalog]: configured and running, proceeding with master startup.
16:04:42.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.181430 11677 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [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: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } } }
16:04:42.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.182116 11677 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [sys.catalog]: This master's current role is: FOLLOWER
16:04:42.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.185030 11688 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
16:04:42.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.185345 11688 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
16:04:42.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.185070 11598 master_runner.cc:186] Error getting master registration for 127.11.45.190:42895: OK, instance_id { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" instance_seqno: 1783526681783039 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
16:04:42.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.188463 11598 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
16:04:42.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.191388 11596 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } attempt: 3
16:04:42.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.197165 11596 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376: Bootstrap starting.
16:04:42.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.198391 11596 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376: Neither blocks nor log segments found. Creating new log.
16:04:42.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.199354 11596 log.cc:824] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376: Log is configured to *not* fsync() on all Append() calls
16:04:42.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.200337 11596 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376: No bootstrap required, opened a new log
16:04:42.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.204543 11596 raft_consensus.cc:348] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } }
16:04:42.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.204730 11596 raft_consensus.cc:374] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:04:42.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.204768 11596 raft_consensus.cc:729] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 31e609614ce44bc3a3c2d4d690c35376, State: Initialized, Role: FOLLOWER
16:04:42.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.204907 11596 consensus_queue.cc:260] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [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: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } }
16:04:42.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.205384 11596 sys_catalog.cc:564] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [sys.catalog]: configured and running, proceeding with master startup.
16:04:42.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.205317 11691 sys_catalog.cc:455] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [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: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } } }
16:04:42.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.205485 11691 sys_catalog.cc:458] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [sys.catalog]: This master's current role is: FOLLOWER
16:04:42.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.208663 11702 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
16:04:42.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.208910 11702 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
16:04:42.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.208451 11528 master_runner.cc:186] Error getting master registration for 127.11.45.190:42895: OK, instance_id { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" instance_seqno: 1783526681783039 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
16:04:42.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.211944 11528 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
16:04:42.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.224690 11524 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } attempt: 3
16:04:42.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.231655 11524 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055: Bootstrap starting.
16:04:42.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.233136 11524 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055: Neither blocks nor log segments found. Creating new log.
16:04:42.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.233848 11524 log.cc:824] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055: Log is configured to *not* fsync() on all Append() calls
16:04:42.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.235014 11524 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055: No bootstrap required, opened a new log
16:04:42.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.238734 11524 raft_consensus.cc:348] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } }
16:04:42.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.238894 11524 raft_consensus.cc:374] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:04:42.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.238930 11524 raft_consensus.cc:729] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ff17621c3b0a4836bde7b6e4eeb82055, State: Initialized, Role: FOLLOWER
16:04:42.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.239120 11524 consensus_queue.cc:260] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [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: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } }
16:04:42.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.239595 11524 sys_catalog.cc:564] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [sys.catalog]: configured and running, proceeding with master startup.
16:04:42.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.241029 11705 sys_catalog.cc:455] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [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: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } } }
16:04:42.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.241364 11705 sys_catalog.cc:458] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [sys.catalog]: This master's current role is: FOLLOWER
16:04:42.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.242686 11716 catalog_manager.cc:1558] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
16:04:42.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.243593 11716 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
16:04:42.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.245301 11457 master_runner.cc:263] No leader master found from master ff17621c3b0a4836bde7b6e4eeb82055
16:04:42.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.245349 11457 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
16:04:42.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.277957 11477 tablet.cc:2369] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:04:42.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.392498 11621 tablet.cc:2369] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:04:42.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.447506 11549 tablet.cc:2369] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:04:42.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.506212 11691 raft_consensus.cc:482] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
16:04:42.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.506420 11691 raft_consensus.cc:504] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } }
16:04:42.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.506760 11691 leader_election.cc:288] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers ff17621c3b0a4836bde7b6e4eeb82055 (127.11.45.190:42895), 7178e3a7fff1457ea7f68acccc835bc7 (127.11.45.188:35349)
16:04:42.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.507159 11641 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "31e609614ce44bc3a3c2d4d690c35376" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7178e3a7fff1457ea7f68acccc835bc7" is_pre_election: true
16:04:42.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.507217 11498 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "31e609614ce44bc3a3c2d4d690c35376" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" is_pre_election: true
16:04:42.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.507341 11641 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 31e609614ce44bc3a3c2d4d690c35376 in term 0.
16:04:42.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.507460 11498 raft_consensus.cc:2454] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 31e609614ce44bc3a3c2d4d690c35376 in term 0.
16:04:42.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.507745 11545 leader_election.cc:302] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [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: 31e609614ce44bc3a3c2d4d690c35376, 7178e3a7fff1457ea7f68acccc835bc7; no voters: 
16:04:42.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.507953 11691 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [term 0 FOLLOWER]: Leader pre-election won for term 1
16:04:42.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.508044 11691 raft_consensus.cc:482] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
16:04:42.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.508067 11691 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [term 0 FOLLOWER]: Advancing to term 1
16:04:42.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.509238 11691 raft_consensus.cc:504] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } }
16:04:42.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.509399 11691 leader_election.cc:288] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [CANDIDATE]: Term 1 election: Requested vote from peers ff17621c3b0a4836bde7b6e4eeb82055 (127.11.45.190:42895), 7178e3a7fff1457ea7f68acccc835bc7 (127.11.45.188:35349)
16:04:42.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.509546 11498 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "31e609614ce44bc3a3c2d4d690c35376" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ff17621c3b0a4836bde7b6e4eeb82055"
16:04:42.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.509613 11641 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "31e609614ce44bc3a3c2d4d690c35376" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7178e3a7fff1457ea7f68acccc835bc7"
16:04:42.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.509644 11498 raft_consensus.cc:3037] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [term 0 FOLLOWER]: Advancing to term 1
16:04:42.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.509712 11641 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [term 0 FOLLOWER]: Advancing to term 1
16:04:42.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.510861 11641 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 31e609614ce44bc3a3c2d4d690c35376 in term 1.
16:04:42.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.510862 11498 raft_consensus.cc:2454] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 31e609614ce44bc3a3c2d4d690c35376 in term 1.
16:04:42.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.511057 11544 leader_election.cc:302] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [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: 31e609614ce44bc3a3c2d4d690c35376, ff17621c3b0a4836bde7b6e4eeb82055; no voters: 
16:04:42.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.511130 11691 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [term 1 FOLLOWER]: Leader election won for term 1
16:04:42.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.511318 11691 raft_consensus.cc:686] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [term 1 LEADER]: Becoming Leader. State: Replica: 31e609614ce44bc3a3c2d4d690c35376, State: Running, Role: LEADER
16:04:42.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.511428 11691 consensus_queue.cc:237] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [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: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } }
16:04:42.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.511962 11718 sys_catalog.cc:455] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 31e609614ce44bc3a3c2d4d690c35376. Latest consensus state: current_term: 1 leader_uuid: "31e609614ce44bc3a3c2d4d690c35376" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } } }
16:04:42.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.512661 11718 sys_catalog.cc:458] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [sys.catalog]: This master's current role is: LEADER
16:04:42.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.513264 11720 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
16:04:42.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.513507 11720 catalog_manager.cc:1484] Initializing Kudu cluster ID...
16:04:42.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.515641 11498 raft_consensus.cc:1261] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [term 1 FOLLOWER]: Refusing update from remote peer 31e609614ce44bc3a3c2d4d690c35376: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
16:04:42.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.515640 11641 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [term 1 FOLLOWER]: Refusing update from remote peer 31e609614ce44bc3a3c2d4d690c35376: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
16:04:42.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.516007 11718 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [LEADER]: Connected to new peer: Peer: permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
16:04:42.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.516141 11691 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [LEADER]: Connected to new peer: Peer: permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
16:04:42.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.517952 11677 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 31e609614ce44bc3a3c2d4d690c35376. Latest consensus state: current_term: 1 leader_uuid: "31e609614ce44bc3a3c2d4d690c35376" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } } }
16:04:42.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.518090 11677 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [sys.catalog]: This master's current role is: FOLLOWER
16:04:42.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.518385 11705 sys_catalog.cc:455] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 31e609614ce44bc3a3c2d4d690c35376. Latest consensus state: current_term: 1 leader_uuid: "31e609614ce44bc3a3c2d4d690c35376" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } } }
16:04:42.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.518527 11705 sys_catalog.cc:458] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [sys.catalog]: This master's current role is: FOLLOWER
16:04:42.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.519636 11691 sys_catalog.cc:455] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "31e609614ce44bc3a3c2d4d690c35376" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } } }
16:04:42.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.519726 11691 sys_catalog.cc:458] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [sys.catalog]: This master's current role is: LEADER
16:04:42.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.519804 11722 mvcc.cc:205] Tried to move back new op lower bound from 7305325291581390848 to 7305325291567550464. Current Snapshot: MvccSnapshot[applied={T|T < 7305325291581390848}]
16:04:42.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.519919 11691 sys_catalog.cc:455] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "31e609614ce44bc3a3c2d4d690c35376" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } } }
16:04:42.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.519997 11691 sys_catalog.cc:458] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376 [sys.catalog]: This master's current role is: LEADER
16:04:42.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.520087 11705 sys_catalog.cc:455] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "31e609614ce44bc3a3c2d4d690c35376" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } } }
16:04:42.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.520165 11705 sys_catalog.cc:458] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055 [sys.catalog]: This master's current role is: FOLLOWER
16:04:42.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.520506 11677 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "31e609614ce44bc3a3c2d4d690c35376" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff17621c3b0a4836bde7b6e4eeb82055" member_type: VOTER last_known_addr { host: "127.11.45.190" port: 42895 } } peers { permanent_uuid: "31e609614ce44bc3a3c2d4d690c35376" member_type: VOTER last_known_addr { host: "127.11.45.189" port: 33751 } } peers { permanent_uuid: "7178e3a7fff1457ea7f68acccc835bc7" member_type: VOTER last_known_addr { host: "127.11.45.188" port: 35349 } } }
16:04:42.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.520620 11677 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7 [sys.catalog]: This master's current role is: FOLLOWER
16:04:42.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.521180 11720 catalog_manager.cc:1347] Generated new cluster ID: f9cbec3f973541518b9d49ec696b54d6
16:04:42.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.521227 11720 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
16:04:42.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.550884 11720 catalog_manager.cc:1370] Generated new certificate authority record
16:04:42.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.551738 11720 catalog_manager.cc:1504] Loading token signing keys...
16:04:42.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.560331 11720 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 31e609614ce44bc3a3c2d4d690c35376: Generated new TSK 0
16:04:42.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.560606 11720 catalog_manager.cc:1514] Initializing in-progress tserver states...
16:04:42.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.581282 11446 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:42.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/wal
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/data
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/logs
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/data/info.pb
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:42.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:42.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:42.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:04:42.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:04:42.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.129:0
16:04:42.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.45.129
16:04:42.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.129
16:04:42.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:42.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:42.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:42.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:42.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:42.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:04:42.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.703560 11730 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:04:42.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.703815 11730 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:04:42.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.703838 11730 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:04:42.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.705431 11730 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:04:42.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.705518 11730 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.11.45.129
16:04:42.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.707609 11730 tablet_server_runner.cc:78] Tablet server non-default flags:
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/data
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/wal
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.129:0
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/data/info.pb
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.129
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.11730
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.45.129
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/logs
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 14:54:46 UTC on ccycloud.quasar-lejogm.root.comops.site
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493842
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.707919 11730 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:04:42.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.708365 11730 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:04:42.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.715523 11735 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
16:04:42.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.715646 11738 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
16:04:42.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.715519 11736 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
16:04:42.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.715916 11730 server_base.cc:1034] running on GCE node
16:04:42.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.716157 11730 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:04:42.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.716473 11730 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:04:42.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.717635 11730 hybrid_clock.cc:648] HybridClock initialized: now 1783526682717606 us; error 43 us; skew 500 ppm
16:04:42.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.719467 11730 webserver.cc:460] Webserver started at http://127.11.45.129:40951/ using document root <none> and password file <none>
16:04:42.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.719810 11730 fs_manager.cc:359] Metadata directory not provided
16:04:42.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.719897 11730 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:04:42.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.720062 11730 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:04:42.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.721285 11730 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/data/instance:
16:04:42.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c6149f6002b94e1a94ed92af9d0f770e"
16:04:42.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:42 on dist-test-slave-2v85"
16:04:42.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.721781 11730 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/wal/instance:
16:04:42.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c6149f6002b94e1a94ed92af9d0f770e"
16:04:42.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:42 on dist-test-slave-2v85"
16:04:42.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.723709 11730 fs_manager.cc:691] Time spent creating directory manager: real 0.002s	user 0.000s	sys 0.001s
16:04:42.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.724720 11744 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.724925 11730 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.725024 11730 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/data,/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/wal
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c6149f6002b94e1a94ed92af9d0f770e"
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:42 on dist-test-slave-2v85"
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.725108 11730 fs_report.cc:383] FS layout report
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/wal
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/wal
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/data/data
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:04:42.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:04:42.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:04:42.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:04:42.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:04:42.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:04:42.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:04:42.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.745684 11730 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:04:42.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.746451 11730 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
16:04:42.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.746686 11730 kserver.cc:163] Server-wide thread pool size limit: 3276
16:04:42.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.747119 11730 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:04:42.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.747648 11730 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:04:42.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.747722 11730 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:04:42.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.747761 11730 ts_tablet_manager.cc:610] Registered 0 tablets
16:04:42.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.747778 11730 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:04:42.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.759224 11730 rpc_server.cc:307] RPC server started. Bound to: 127.11.45.129:45461
16:04:42.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.759311 11857 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.11.45.129:45461 every 8 connection(s)
16:04:42.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.759804 11730 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/data/info.pb
16:04:42.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.760643 11446 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskGYRXSD/build/release/bin/kudu as pid 11730
16:04:42.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.760728 11446 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-0/wal/instance
16:04:42.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.762874 11446 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:42.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:42.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/wal
16:04:42.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/data
16:04:42.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:04:42.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:04:42.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:04:42.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:42.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:42.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:42.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/logs
16:04:42.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/data/info.pb
16:04:42.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:42.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:04:42.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:04:42.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:04:42.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:04:42.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:42.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.130:0
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.45.130
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.130
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:42.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:04:42.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.771788 11860 heartbeater.cc:347] Connected to a master server at 127.11.45.189:33751
16:04:42.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.771905 11860 heartbeater.cc:464] Registering TS with master...
16:04:42.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.772574 11860 heartbeater.cc:511] Master 127.11.45.189:33751 requested a full tablet report, sending...
16:04:42.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.773231 11560 ts_manager.cc:194] Registered new tserver with Master: c6149f6002b94e1a94ed92af9d0f770e (127.11.45.129:45461)
16:04:42.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.774361 11560 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.11.45.129:50945
16:04:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.776252 11859 heartbeater.cc:347] Connected to a master server at 127.11.45.190:42895
16:04:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.776458 11859 heartbeater.cc:464] Registering TS with master...
16:04:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.776576 11859 heartbeater.cc:511] Master 127.11.45.190:42895 requested a full tablet report, sending...
16:04:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.777042 11488 ts_manager.cc:194] Registered new tserver with Master: c6149f6002b94e1a94ed92af9d0f770e (127.11.45.129:45461)
16:04:42.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.778782 11858 heartbeater.cc:347] Connected to a master server at 127.11.45.188:35349
16:04:42.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.778841 11858 heartbeater.cc:464] Registering TS with master...
16:04:42.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.778889 11858 heartbeater.cc:511] Master 127.11.45.188:35349 requested a full tablet report, sending...
16:04:42.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.779295 11632 ts_manager.cc:194] Registered new tserver with Master: c6149f6002b94e1a94ed92af9d0f770e (127.11.45.129:45461)
16:04:42.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.890854 11868 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:04:42.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.891105 11868 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:04:42.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.891125 11868 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:04:42.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.892804 11868 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:04:42.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.892885 11868 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.11.45.130
16:04:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.894505 11868 tablet_server_runner.cc:78] Tablet server non-default flags:
16:04:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:04:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/data
16:04:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/wal
16:04:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.130:0
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/data/info.pb
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.130
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.11868
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.45.130
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/logs
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:04:42.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:04:42.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
16:04:42.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 14:54:46 UTC on ccycloud.quasar-lejogm.root.comops.site
16:04:42.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493842
16:04:42.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.894757 11868 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:04:42.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.895102 11868 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:04:42.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.901815 11874 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
16:04:42.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.901834 11876 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
16:04:42.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:42.901846 11873 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
16:04:42.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.902679 11868 server_base.cc:1034] running on GCE node
16:04:42.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.903007 11868 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:04:42.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.903321 11868 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:04:42.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.904528 11868 hybrid_clock.cc:648] HybridClock initialized: now 1783526682904513 us; error 37 us; skew 500 ppm
16:04:42.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.906586 11868 webserver.cc:460] Webserver started at http://127.11.45.130:40147/ using document root <none> and password file <none>
16:04:42.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.906975 11868 fs_manager.cc:359] Metadata directory not provided
16:04:42.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.907042 11868 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:04:42.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.907225 11868 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:04:42.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.908666 11868 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/data/instance:
16:04:42.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "77090507e5af49f8ba5e112dc5345615"
16:04:42.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:42 on dist-test-slave-2v85"
16:04:42.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.909210 11868 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/wal/instance:
16:04:42.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "77090507e5af49f8ba5e112dc5345615"
16:04:42.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:42 on dist-test-slave-2v85"
16:04:42.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.910887 11868 fs_manager.cc:691] Time spent creating directory manager: real 0.002s	user 0.004s	sys 0.000s
16:04:42.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.911772 11882 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.912005 11868 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.912102 11868 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/data,/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/wal
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "77090507e5af49f8ba5e112dc5345615"
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:42 on dist-test-slave-2v85"
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.912194 11868 fs_report.cc:383] FS layout report
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/wal
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/wal
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/data/data
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:04:42.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:04:42.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:04:42.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:04:42.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.922701 11868 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:04:42.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.923241 11868 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
16:04:42.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.923442 11868 kserver.cc:163] Server-wide thread pool size limit: 3276
16:04:42.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.923748 11868 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:04:42.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.924108 11868 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:04:42.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.924137 11868 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:04:42.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.924160 11868 ts_tablet_manager.cc:610] Registered 0 tablets
16:04:42.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.924173 11868 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:04:42.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.935570 11868 rpc_server.cc:307] RPC server started. Bound to: 127.11.45.130:41743
16:04:42.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.935714 11995 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.11.45.130:41743 every 8 connection(s)
16:04:42.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.936049 11868 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/data/info.pb
16:04:42.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.939826 11446 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskGYRXSD/build/release/bin/kudu as pid 11868
16:04:42.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.939924 11446 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-1/wal/instance
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.941854 11446 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskGYRXSD/build/release/bin/kudu
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/wal
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/data
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/logs
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/data/info.pb
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:04:42.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.131:0
16:04:42.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.45.131
16:04:42.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.131
16:04:42.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:42.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:42.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:42.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:42.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:42.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:04:42.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.945323 11996 heartbeater.cc:347] Connected to a master server at 127.11.45.188:35349
16:04:42.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.945343 11997 heartbeater.cc:347] Connected to a master server at 127.11.45.190:42895
16:04:42.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.945474 11996 heartbeater.cc:464] Registering TS with master...
16:04:42.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.945477 11997 heartbeater.cc:464] Registering TS with master...
16:04:42.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.945699 11996 heartbeater.cc:511] Master 127.11.45.188:35349 requested a full tablet report, sending...
16:04:42.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.945701 11997 heartbeater.cc:511] Master 127.11.45.190:42895 requested a full tablet report, sending...
16:04:42.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.946309 11488 ts_manager.cc:194] Registered new tserver with Master: 77090507e5af49f8ba5e112dc5345615 (127.11.45.130:41743)
16:04:42.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.946633 11632 ts_manager.cc:194] Registered new tserver with Master: 77090507e5af49f8ba5e112dc5345615 (127.11.45.130:41743)
16:04:42.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.947477 11998 heartbeater.cc:347] Connected to a master server at 127.11.45.189:33751
16:04:42.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.947553 11998 heartbeater.cc:464] Registering TS with master...
16:04:42.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.947616 11998 heartbeater.cc:511] Master 127.11.45.189:33751 requested a full tablet report, sending...
16:04:42.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.947855 11560 ts_manager.cc:194] Registered new tserver with Master: 77090507e5af49f8ba5e112dc5345615 (127.11.45.130:41743)
16:04:42.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:42.948268 11560 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.11.45.130:50849
16:04:43.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:43.060570 12003 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:04:43.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:43.060858 12003 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:04:43.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:43.060881 12003 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:04:43.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:43.062176 12003 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:04:43.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:43.062232 12003 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.11.45.131
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.063567 12003 tablet_server_runner.cc:78] Tablet server non-default flags:
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.45.148:46121
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/data
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/wal
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.45.131:0
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/data/info.pb
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.45.131
16:04:43.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.45.190:42895,127.11.45.189:33751,127.11.45.188:35349
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.12003
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.45.131
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/logs
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 14:54:46 UTC on ccycloud.quasar-lejogm.root.comops.site
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493842
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.063795 12003 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:04:43.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.064126 12003 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:04:43.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:43.070253 12011 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
16:04:43.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:43.070297 12009 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
16:04:43.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:43.070322 12008 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
16:04:43.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.070613 12003 server_base.cc:1034] running on GCE node
16:04:43.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.070876 12003 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:04:43.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.071184 12003 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:04:43.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.072412 12003 hybrid_clock.cc:648] HybridClock initialized: now 1783526683072390 us; error 36 us; skew 500 ppm
16:04:43.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.074455 12003 webserver.cc:460] Webserver started at http://127.11.45.131:37783/ using document root <none> and password file <none>
16:04:43.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.074677 12003 fs_manager.cc:359] Metadata directory not provided
16:04:43.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.074721 12003 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:04:43.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.074831 12003 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:04:43.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.076046 12003 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/data/instance:
16:04:43.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "157e22e3e3d04a829df9fd23c036a1a4"
16:04:43.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:43 on dist-test-slave-2v85"
16:04:43.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.076484 12003 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/wal/instance:
16:04:43.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "157e22e3e3d04a829df9fd23c036a1a4"
16:04:43.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:43 on dist-test-slave-2v85"
16:04:43.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.078507 12003 fs_manager.cc:691] Time spent creating directory manager: real 0.002s	user 0.004s	sys 0.000s
16:04:43.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.079421 12017 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:04:43.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.079610 12003 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
16:04:43.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.079707 12003 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/data,/tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/wal
16:04:43.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "157e22e3e3d04a829df9fd23c036a1a4"
16:04:43.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 16:04:43 on dist-test-slave-2v85"
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.079816 12003 fs_report.cc:383] FS layout report
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/wal
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/wal
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/data/data
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:04:43.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:04:43.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.092832 12003 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:04:43.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.093408 12003 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
16:04:43.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.093668 12003 kserver.cc:163] Server-wide thread pool size limit: 3276
16:04:43.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.094388 12003 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:04:43.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.095163 12003 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:04:43.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.095220 12003 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:04:43.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.095255 12003 ts_tablet_manager.cc:610] Registered 0 tablets
16:04:43.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.095278 12003 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:04:43.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.110889 12003 rpc_server.cc:307] RPC server started. Bound to: 127.11.45.131:42623
16:04:43.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.111817 12003 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/data/info.pb
16:04:43.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.111970 11446 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskGYRXSD/build/release/bin/kudu as pid 12003
16:04:43.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.112090 11446 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskGYRXSD/test-tmp/mini-kudu-cluster6133429885010678253/ts-2/wal/instance
16:04:43.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.110986 12130 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.11.45.131:42623 every 8 connection(s)
16:04:43.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.121083 12133 heartbeater.cc:347] Connected to a master server at 127.11.45.189:33751
16:04:43.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.121093 12131 heartbeater.cc:347] Connected to a master server at 127.11.45.188:35349
16:04:43.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.121248 12133 heartbeater.cc:464] Registering TS with master...
16:04:43.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.121490 12133 heartbeater.cc:511] Master 127.11.45.189:33751 requested a full tablet report, sending...
16:04:43.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.121248 12131 heartbeater.cc:464] Registering TS with master...
16:04:43.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.121762 12132 heartbeater.cc:347] Connected to a master server at 127.11.45.190:42895
16:04:43.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.121793 12131 heartbeater.cc:511] Master 127.11.45.188:35349 requested a full tablet report, sending...
16:04:43.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.121798 12132 heartbeater.cc:464] Registering TS with master...
16:04:43.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.121870 12132 heartbeater.cc:511] Master 127.11.45.190:42895 requested a full tablet report, sending...
16:04:43.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.121917 11560 ts_manager.cc:194] Registered new tserver with Master: 157e22e3e3d04a829df9fd23c036a1a4 (127.11.45.131:42623)
16:04:43.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.122145 11632 ts_manager.cc:194] Registered new tserver with Master: 157e22e3e3d04a829df9fd23c036a1a4 (127.11.45.131:42623)
16:04:43.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.122161 11488 ts_manager.cc:194] Registered new tserver with Master: 157e22e3e3d04a829df9fd23c036a1a4 (127.11.45.131:42623)
16:04:43.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.122489 11560 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.11.45.131:48759
16:04:43.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.131871 11446 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
16:04:43.133 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
16:04:43.134 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

16:04:43.144 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.11.45.190"
      port: 42895
    }
    bound_http_address {
      host: "127.11.45.190"
      port: 42435
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.11.45.189"
      port: 33751
    }
    bound_http_address {
      host: "127.11.45.189"
      port: 43667
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.11.45.188"
      port: 35349
    }
    bound_http_address {
      host: "127.11.45.188"
      port: 35101
    }
  }
}

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

16:04:43.156 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.11.45.129"
      port: 45461
    }
    bound_http_address {
      host: "127.11.45.129"
      port: 40951
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.11.45.130"
      port: 41743
    }
    bound_http_address {
      host: "127.11.45.130"
      port: 40147
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.11.45.131"
      port: 42623
    }
    bound_http_address {
      host: "127.11.45.131"
      port: 37783
    }
  }
}

16:04:43.160 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
16:04:43.171 [DEBUG - main] (InternalLoggerFactory.java:63) Using SLF4J as the default logging framework
16:04:43.176 [DEBUG - main] (ResourceLeakDetector.java:129) -Dorg.apache.kudu.shaded.io.netty.leakDetection.level: simple
16:04:43.177 [DEBUG - main] (ResourceLeakDetector.java:130) -Dorg.apache.kudu.shaded.io.netty.leakDetection.targetRecords: 4
16:04:43.183 [DEBUG - main] (ResourceLeakDetectorFactory.java:196) Loaded default ResourceLeakDetector: org.apache.kudu.shaded.io.netty.util.ResourceLeakDetector@68044f4
16:04:43.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.186319 11688 catalog_manager.cc:1259] Loaded cluster ID: f9cbec3f973541518b9d49ec696b54d6
16:04:43.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.186431 11688 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7: loading cluster ID for follower catalog manager: success
16:04:43.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.187881 11688 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7: acquiring CA information for follower catalog manager: success
16:04:43.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.188388 11688 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 7178e3a7fff1457ea7f68acccc835bc7: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
16:04:43.205 [DEBUG - main] (PlatformDependent0.java:497) -Dio.netty.noUnsafe: false
16:04:43.205 [DEBUG - main] (PlatformDependent0.java:1001) Java version: 8
16:04:43.206 [DEBUG - main] (PlatformDependent0.java:137) sun.misc.Unsafe.theUnsafe: available
16:04:43.207 [DEBUG - main] (PlatformDependent0.java:161) sun.misc.Unsafe.copyMemory: available
16:04:43.207 [DEBUG - main] (PlatformDependent0.java:193) sun.misc.Unsafe.storeFence: available
16:04:43.208 [DEBUG - main] (PlatformDependent0.java:236) java.nio.Buffer.address: available
16:04:43.208 [DEBUG - main] (PlatformDependent0.java:308) direct buffer constructor: available
16:04:43.209 [DEBUG - main] (PlatformDependent0.java:386) java.nio.Bits.unaligned: available, true
16:04:43.209 [DEBUG - main] (PlatformDependent0.java:460) jdk.internal.misc.Unsafe.allocateUninitializedArray(int): unavailable prior to Java9
16:04:43.209 [DEBUG - main] (PlatformDependent0.java:483) java.nio.DirectByteBuffer.<init>(long, {int,long}): available
16:04:43.209 [DEBUG - main] (PlatformDependent.java:1159) sun.misc.Unsafe: available
16:04:43.209 [DEBUG - main] (PlatformDependent.java:1289) -Dio.netty.tmpdir: /tmp (java.io.tmpdir)
16:04:43.210 [DEBUG - main] (PlatformDependent.java:1368) -Dio.netty.bitMode: 64 (sun.arch.data.model)
16:04:43.211 [DEBUG - main] (PlatformDependent.java:178) -Dio.netty.maxDirectMemory: 3799121920 bytes
16:04:43.211 [DEBUG - main] (PlatformDependent.java:185) -Dio.netty.uninitializedArrayAllocationThreshold: -1
16:04:43.212 [DEBUG - main] (CleanerJava6.java:92) java.nio.ByteBuffer.cleaner(): available
16:04:43.212 [DEBUG - main] (PlatformDependent.java:205) -Dio.netty.noPreferDirect: false
16:04:43.222 [DEBUG - main] (PlatformDependent.java:1010) org.jctools-core.MpscChunkedArrayQueue: available
16:04:43.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.244385 11716 catalog_manager.cc:1259] Loaded cluster ID: f9cbec3f973541518b9d49ec696b54d6
16:04:43.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.244504 11716 catalog_manager.cc:1552] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055: loading cluster ID for follower catalog manager: success
16:04:43.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.245648 11716 catalog_manager.cc:1574] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055: acquiring CA information for follower catalog manager: success
16:04:43.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.246217 11716 catalog_manager.cc:1602] T 00000000000000000000000000000000 P ff17621c3b0a4836bde7b6e4eeb82055: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
16:04:43.264 [DEBUG - main] (MultithreadEventLoopGroup.java:44) -Dio.netty.eventLoopThreads: 2
16:04:43.279 [DEBUG - main] (GlobalEventExecutor.java:53) -Dio.netty.globalEventExecutor.quietPeriodSeconds: 1
16:04:43.286 [DEBUG - main] (InternalThreadLocalMap.java:100) -Dio.netty.threadLocalMap.stringBuilder.initialSize: 1024
16:04:43.286 [DEBUG - main] (InternalThreadLocalMap.java:101) -Dio.netty.threadLocalMap.stringBuilder.maxSize: 4096
16:04:43.294 [DEBUG - main] (NioEventLoop.java:110) -Dio.netty.noKeySetOptimization: false
16:04:43.294 [DEBUG - main] (NioEventLoop.java:111) -Dio.netty.selectorAutoRebuildThreshold: 512
16:04:43.343 [DEBUG - main] (PooledByteBufAllocator.java:157) -Dio.netty.allocator.numHeapArenas: 2
16:04:43.343 [DEBUG - main] (PooledByteBufAllocator.java:158) -Dio.netty.allocator.numDirectArenas: 2
16:04:43.343 [DEBUG - main] (PooledByteBufAllocator.java:160) -Dio.netty.allocator.pageSize: 8192
16:04:43.343 [DEBUG - main] (PooledByteBufAllocator.java:165) -Dio.netty.allocator.maxOrder: 9
16:04:43.344 [DEBUG - main] (PooledByteBufAllocator.java:169) -Dio.netty.allocator.chunkSize: 4194304
16:04:43.344 [DEBUG - main] (PooledByteBufAllocator.java:170) -Dio.netty.allocator.smallCacheSize: 256
16:04:43.344 [DEBUG - main] (PooledByteBufAllocator.java:171) -Dio.netty.allocator.normalCacheSize: 64
16:04:43.344 [DEBUG - main] (PooledByteBufAllocator.java:172) -Dio.netty.allocator.maxCachedBufferCapacity: 32768
16:04:43.344 [DEBUG - main] (PooledByteBufAllocator.java:173) -Dio.netty.allocator.cacheTrimInterval: 8192
16:04:43.344 [DEBUG - main] (PooledByteBufAllocator.java:174) -Dio.netty.allocator.cacheTrimIntervalMillis: 0
16:04:43.344 [DEBUG - main] (PooledByteBufAllocator.java:175) -Dio.netty.allocator.useCacheForAllThreads: false
16:04:43.345 [DEBUG - main] (PooledByteBufAllocator.java:176) -Dio.netty.allocator.maxCachedByteBuffersPerChunk: 1023
16:04:43.381 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
16:04:43.547 [INFO - main] (Logging.scala:57) Running Spark version 3.1.2
16:04:43.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.775600 11860 heartbeater.cc:503] Master 127.11.45.189:33751 was elected leader, sending a full tablet report...
16:04:43.826 [WARN - main] (NativeCodeLoader.java:60) Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
16:04:43.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:43.949071 11998 heartbeater.cc:503] Master 127.11.45.189:33751 was elected leader, sending a full tablet report...
16:04:43.980 [INFO - main] (Logging.scala:57) ==============================================================
16:04:43.981 [INFO - main] (Logging.scala:57) No custom resources configured for spark.driver.
16:04:43.982 [INFO - main] (Logging.scala:57) ==============================================================
16:04:43.983 [INFO - main] (Logging.scala:57) Submitted application: test
16:04:44.023 [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)
16:04:44.042 [INFO - main] (Logging.scala:57) Limiting resource is cpu
16:04:44.043 [INFO - main] (Logging.scala:57) Added ResourceProfile id: 0
16:04:44.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:44.123353 12133 heartbeater.cc:503] Master 127.11.45.189:33751 was elected leader, sending a full tablet report...
16:04:44.220 [INFO - main] (Logging.scala:57) Changing view acls to: slave
16:04:44.221 [INFO - main] (Logging.scala:57) Changing modify acls to: slave
16:04:44.222 [INFO - main] (Logging.scala:57) Changing view acls groups to: 
16:04:44.223 [INFO - main] (Logging.scala:57) Changing modify acls groups to: 
16:04:44.223 [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()
16:04:44.630 [INFO - main] (Logging.scala:57) Successfully started service 'sparkDriver' on port 36067.
16:04:44.670 [INFO - main] (Logging.scala:57) Registering MapOutputTracker
16:04:44.715 [INFO - main] (Logging.scala:57) Registering BlockManagerMaster
16:04:44.745 [INFO - main] (Logging.scala:57) Using org.apache.spark.storage.DefaultTopologyMapper for getting topology information
16:04:44.746 [INFO - main] (Logging.scala:57) BlockManagerMasterEndpoint up
16:04:44.753 [INFO - main] (Logging.scala:57) Registering BlockManagerMasterHeartbeat
16:04:44.773 [INFO - main] (Logging.scala:57) Created local directory at /tmp/blockmgr-75a09037-2340-428e-8cc7-646bef04bece
16:04:44.831 [INFO - main] (Logging.scala:57) MemoryStore started with capacity 1993.9 MiB
16:04:44.856 [INFO - main] (Logging.scala:57) Registering OutputCommitCoordinator
16:04:45.076 [INFO - main] (Logging.scala:57) Starting executor ID driver on host dist-test-slave-2v85.c.gcp-upstream.internal
16:04:45.124 [INFO - main] (Logging.scala:57) Successfully started service 'org.apache.spark.network.netty.NettyBlockTransferService' on port 44699.
16:04:45.124 [INFO - main] (NettyBlockTransferService.scala:81) Server created on dist-test-slave-2v85.c.gcp-upstream.internal:44699
16:04:45.127 [INFO - main] (Logging.scala:57) Using org.apache.spark.storage.RandomBlockReplicationPolicy for block replication policy
16:04:45.138 [INFO - main] (Logging.scala:57) Registering BlockManager BlockManagerId(driver, dist-test-slave-2v85.c.gcp-upstream.internal, 44699, None)
16:04:45.146 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Registering block manager dist-test-slave-2v85.c.gcp-upstream.internal:44699 with 1993.9 MiB RAM, BlockManagerId(driver, dist-test-slave-2v85.c.gcp-upstream.internal, 44699, None)
16:04:45.152 [INFO - main] (Logging.scala:57) Registered BlockManager BlockManagerId(driver, dist-test-slave-2v85.c.gcp-upstream.internal, 44699, None)
16:04:45.154 [INFO - main] (Logging.scala:57) Initialized BlockManager: BlockManagerId(driver, dist-test-slave-2v85.c.gcp-upstream.internal, 44699, None)
16:04:45.460 [INFO - main] (Log.java:169) Logging initialized @6252ms to org.sparkproject.jetty.util.log.Slf4jLog
16:04:45.748 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
16:04:45.807 [DEBUG - main] (Connection.java:748) [peer master-127.11.45.190:42895(127.11.45.190:42895)] connecting to peer
16:04:45.814 [DEBUG - main] (DefaultChannelId.java:79) -Dio.netty.processId: 11433 (auto-detected)
16:04:45.817 [DEBUG - main] (NetUtil.java:148) -Djava.net.preferIPv4Stack: true
16:04:45.817 [DEBUG - main] (NetUtil.java:149) -Djava.net.preferIPv6Addresses: false
16:04:45.820 [DEBUG - main] (NetUtilInitializations.java:145) Loopback interface: lo (lo, 127.0.0.1)
16:04:45.821 [DEBUG - main] (NetUtil.java:188) /proc/sys/net/core/somaxconn: 4096
16:04:45.822 [DEBUG - main] (DefaultChannelId.java:101) -Dio.netty.machineId: 02:42:dd:ff:fe:51:5d:11 (auto-detected)
16:04:45.849 [DEBUG - main] (ByteBufUtil.java:88) -Dio.netty.allocator.type: pooled
16:04:45.849 [DEBUG - main] (ByteBufUtil.java:97) -Dio.netty.threadLocalDirectBufferSize: 0
16:04:45.849 [DEBUG - main] (ByteBufUtil.java:100) -Dio.netty.maxThreadLocalCharBufferSize: 16384
16:04:45.861 [DEBUG - main] (Connection.java:748) [peer master-127.11.45.188:35349(127.11.45.188:35349)] connecting to peer
16:04:45.863 [DEBUG - main] (Connection.java:748) [peer master-127.11.45.189:33751(127.11.45.189:33751)] connecting to peer
16:04:45.897 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.11.45.188:35349(127.11.45.188:35349)] Successfully connected to peer
16:04:45.897 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.11.45.190:42895(127.11.45.190:42895)] Successfully connected to peer
16:04:45.913 [DEBUG - kudu-nio-0] (AbstractByteBuf.java:63) -Dorg.apache.kudu.shaded.io.netty.buffer.checkAccessible: true
16:04:45.913 [DEBUG - kudu-nio-0] (AbstractByteBuf.java:64) -Dorg.apache.kudu.shaded.io.netty.buffer.checkBounds: true
16:04:45.913 [DEBUG - kudu-nio-0] (ResourceLeakDetectorFactory.java:196) Loaded default ResourceLeakDetector: org.apache.kudu.shaded.io.netty.util.ResourceLeakDetector@2da1396d
16:04:45.920 [DEBUG - kudu-nio-1] (Recycler.java:96) -Dio.netty.recycler.maxCapacityPerThread: 4096
16:04:45.920 [DEBUG - kudu-nio-1] (Recycler.java:97) -Dio.netty.recycler.ratio: 8
16:04:45.920 [DEBUG - kudu-nio-1] (Recycler.java:98) -Dio.netty.recycler.chunkSize: 32
16:04:45.921 [DEBUG - kudu-nio-1] (Recycler.java:99) -Dio.netty.recycler.blocking: false
16:04:45.921 [DEBUG - kudu-nio-1] (Recycler.java:100) -Dio.netty.recycler.batchFastThreadLocalOnly: true
16:04:45.981 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.11.45.189:33751(127.11.45.189:33751)] Successfully connected to peer
16:04:46.005 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.11.45.190
16:04:46.005 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.11.45.188
16:04:46.135 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.11.45.189
16:04:46.245 [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
16:04:46.259 [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
16:04:46.262 [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
16:04:46.261 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x061193a6, L:/127.0.0.1:50112 - R:/127.11.45.188:35349] using SASL/PLAIN
16:04:46.266 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xaf7db968, L:/127.0.0.1:32848 - R:/127.11.45.190:42895] using SASL/PLAIN
16:04:46.293 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xd4bc5307, L:/127.0.0.1:49154 - R:/127.11.45.189:33751] using SASL/PLAIN
16:04:46.332 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.398583 11560 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:49154:
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "test"
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c1_i"
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c2_s"
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c3_double"
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DOUBLE
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c4_long"
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT64
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c5_bool"
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c6_short"
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT16
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c7_float"
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: FLOAT
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c8_binary"
16:04:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BINARY
16:04:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c9_unixtime_micros"
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: UNIXTIME_MICROS
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c10_byte"
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT8
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c11_decimal32"
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL32
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 9
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c12_decimal64"
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL64
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 18
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
16:04:46.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c13_decimal128"
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL128
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 38
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c14_varchar"
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: VARCHAR
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       length: 65535
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
16:04:46.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c15_date"
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DATE
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) split_rows_range_bounds {
16:04:46.406 [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"
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
16:04:46.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
16:04:46.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) owner: "testuser"
16:04:46.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.414853 11792 tablet_service.cc:1467] Processing CreateTablet for tablet 75abdfda63c54e0e842fb70a32b8d4d3 (DEFAULT_TABLE table=test [id=fb69077e22c246139801651da962ed54]), partition=RANGE (key) PARTITION VALUES < 50
16:04:46.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.415511 11792 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 75abdfda63c54e0e842fb70a32b8d4d3. 1 dirs total, 0 dirs full, 0 dirs failed
16:04:46.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.416734 11930 tablet_service.cc:1467] Processing CreateTablet for tablet d174dbda82814959935d19deaaf47e03 (DEFAULT_TABLE table=test [id=fb69077e22c246139801651da962ed54]), partition=RANGE (key) PARTITION 50 <= VALUES
16:04:46.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.417155 11930 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet d174dbda82814959935d19deaaf47e03. 1 dirs total, 0 dirs full, 0 dirs failed
16:04:46.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.421005 12192 tablet_bootstrap.cc:492] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e: Bootstrap starting.
16:04:46.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.421870 12193 tablet_bootstrap.cc:492] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615: Bootstrap starting.
16:04:46.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.422264 12192 tablet_bootstrap.cc:654] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e: Neither blocks nor log segments found. Creating new log.
16:04:46.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.423161 12193 tablet_bootstrap.cc:654] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615: Neither blocks nor log segments found. Creating new log.
16:04:46.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.423235 12192 log.cc:824] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e: Log is configured to *not* fsync() on all Append() calls
16:04:46.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.424041 12192 tablet_bootstrap.cc:492] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e: No bootstrap required, opened a new log
16:04:46.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.424129 12192 ts_tablet_manager.cc:1397] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e: Time spent bootstrapping tablet: real 0.003s	user 0.002s	sys 0.000s
16:04:46.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.424342 12193 log.cc:824] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615: Log is configured to *not* fsync() on all Append() calls
16:04:46.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.426316 12193 tablet_bootstrap.cc:492] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615: No bootstrap required, opened a new log
16:04:46.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.427892 12193 ts_tablet_manager.cc:1397] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615: Time spent bootstrapping tablet: real 0.006s	user 0.002s	sys 0.000s
16:04:46.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.427975 12192 raft_consensus.cc:348] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c6149f6002b94e1a94ed92af9d0f770e" member_type: VOTER last_known_addr { host: "127.11.45.129" port: 45461 } }
16:04:46.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.429044 12192 raft_consensus.cc:374] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:04:46.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.429231 12192 raft_consensus.cc:729] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c6149f6002b94e1a94ed92af9d0f770e, State: Initialized, Role: FOLLOWER
16:04:46.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.429600 12192 consensus_queue.cc:260] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [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: "c6149f6002b94e1a94ed92af9d0f770e" member_type: VOTER last_known_addr { host: "127.11.45.129" port: 45461 } }
16:04:46.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.429867 12192 raft_consensus.cc:388] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
16:04:46.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.430079 12192 raft_consensus.cc:482] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
16:04:46.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.430272 12192 raft_consensus.cc:3037] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [term 0 FOLLOWER]: Advancing to term 1
16:04:46.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.431624 12192 raft_consensus.cc:504] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c6149f6002b94e1a94ed92af9d0f770e" member_type: VOTER last_known_addr { host: "127.11.45.129" port: 45461 } }
16:04:46.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.432031 12192 leader_election.cc:302] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [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: c6149f6002b94e1a94ed92af9d0f770e; no voters: 
16:04:46.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.432417 12192 leader_election.cc:288] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [CANDIDATE]: Term 1 election: Requested vote from peers 
16:04:46.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.432945 12192 ts_tablet_manager.cc:1428] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e: Time spent starting tablet: real 0.009s	user 0.007s	sys 0.000s
16:04:46.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.433019 12193 raft_consensus.cc:348] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "77090507e5af49f8ba5e112dc5345615" member_type: VOTER last_known_addr { host: "127.11.45.130" port: 41743 } }
16:04:46.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.433342 12193 raft_consensus.cc:374] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:04:46.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.433983 12193 raft_consensus.cc:729] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 77090507e5af49f8ba5e112dc5345615, State: Initialized, Role: FOLLOWER
16:04:46.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.434382 12193 consensus_queue.cc:260] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [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: "77090507e5af49f8ba5e112dc5345615" member_type: VOTER last_known_addr { host: "127.11.45.130" port: 41743 } }
16:04:46.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.434686 12193 raft_consensus.cc:388] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
16:04:46.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.434873 12193 raft_consensus.cc:482] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
16:04:46.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.435024 12193 raft_consensus.cc:3037] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [term 0 FOLLOWER]: Advancing to term 1
16:04:46.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.436064 12197 raft_consensus.cc:2781] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [term 1 FOLLOWER]: Leader election won for term 1
16:04:46.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.436259 12193 raft_consensus.cc:504] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "77090507e5af49f8ba5e112dc5345615" member_type: VOTER last_known_addr { host: "127.11.45.130" port: 41743 } }
16:04:46.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.436437 12197 raft_consensus.cc:686] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [term 1 LEADER]: Becoming Leader. State: Replica: c6149f6002b94e1a94ed92af9d0f770e, State: Running, Role: LEADER
16:04:46.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.436530 12193 leader_election.cc:302] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [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: 77090507e5af49f8ba5e112dc5345615; no voters: 
16:04:46.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.436705 12193 leader_election.cc:288] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [CANDIDATE]: Term 1 election: Requested vote from peers 
16:04:46.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.436762 12197 consensus_queue.cc:237] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e [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: "c6149f6002b94e1a94ed92af9d0f770e" member_type: VOTER last_known_addr { host: "127.11.45.129" port: 45461 } }
16:04:46.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.437119 12193 ts_tablet_manager.cc:1428] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615: Time spent starting tablet: real 0.009s	user 0.000s	sys 0.006s
16:04:46.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.439564 12199 raft_consensus.cc:2781] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [term 1 FOLLOWER]: Leader election won for term 1
16:04:46.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 16:04:46.440014 11999 tablet.cc:2369] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:04:46.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.440027 12199 raft_consensus.cc:686] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [term 1 LEADER]: Becoming Leader. State: Replica: 77090507e5af49f8ba5e112dc5345615, State: Running, Role: LEADER
16:04:46.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.440385 11560 catalog_manager.cc:5495] T 75abdfda63c54e0e842fb70a32b8d4d3 P c6149f6002b94e1a94ed92af9d0f770e reported cstate change: term changed from 0 to 1, leader changed from <none> to c6149f6002b94e1a94ed92af9d0f770e (127.11.45.129). New cstate: current_term: 1 leader_uuid: "c6149f6002b94e1a94ed92af9d0f770e" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c6149f6002b94e1a94ed92af9d0f770e" member_type: VOTER last_known_addr { host: "127.11.45.129" port: 45461 } health_report { overall_health: HEALTHY } } }
16:04:46.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.440529 12199 consensus_queue.cc:237] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 [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: "77090507e5af49f8ba5e112dc5345615" member_type: VOTER last_known_addr { host: "127.11.45.130" port: 41743 } }
16:04:46.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.441849 11559 catalog_manager.cc:5495] T d174dbda82814959935d19deaaf47e03 P 77090507e5af49f8ba5e112dc5345615 reported cstate change: term changed from 0 to 1, leader changed from <none> to 77090507e5af49f8ba5e112dc5345615 (127.11.45.130). New cstate: current_term: 1 leader_uuid: "77090507e5af49f8ba5e112dc5345615" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "77090507e5af49f8ba5e112dc5345615" member_type: VOTER last_known_addr { host: "127.11.45.130" port: 41743 } health_report { overall_health: HEALTHY } } }
16:04:46.451 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table fb69077e22c246139801651da962ed54
16:04:46.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.478931 11560 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:49154:
16:04:46.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "simple-test"
16:04:46.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
16:04:46.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
16:04:46.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
16:04:46.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
16:04:46.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:04:46.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "val"
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:04:46.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
16:04:46.488 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table bf2b00236e2641bbaf36365530d87ff2
16:04:46.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.489168 12065 tablet_service.cc:1467] Processing CreateTablet for tablet 8bf6d14772f14399b18f2d5e6c2860a3 (DEFAULT_TABLE table=simple-test [id=bf2b00236e2641bbaf36365530d87ff2]), partition=RANGE (key) PARTITION UNBOUNDED
16:04:46.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.489691 12065 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 8bf6d14772f14399b18f2d5e6c2860a3. 1 dirs total, 0 dirs full, 0 dirs failed
16:04:46.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.493093 12208 tablet_bootstrap.cc:492] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4: Bootstrap starting.
16:04:46.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.494284 12208 tablet_bootstrap.cc:654] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4: Neither blocks nor log segments found. Creating new log.
16:04:46.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.494803 12208 log.cc:824] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4: Log is configured to *not* fsync() on all Append() calls
16:04:46.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.495471 12208 tablet_bootstrap.cc:492] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4: No bootstrap required, opened a new log
16:04:46.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.495553 12208 ts_tablet_manager.cc:1397] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4: Time spent bootstrapping tablet: real 0.003s	user 0.002s	sys 0.000s
16:04:46.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.498400 12208 raft_consensus.cc:348] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "157e22e3e3d04a829df9fd23c036a1a4" member_type: VOTER last_known_addr { host: "127.11.45.131" port: 42623 } }
16:04:46.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.498558 12208 raft_consensus.cc:374] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:04:46.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.498582 12208 raft_consensus.cc:729] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 157e22e3e3d04a829df9fd23c036a1a4, State: Initialized, Role: FOLLOWER
16:04:46.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.498719 12208 consensus_queue.cc:260] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [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: "157e22e3e3d04a829df9fd23c036a1a4" member_type: VOTER last_known_addr { host: "127.11.45.131" port: 42623 } }
16:04:46.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.498788 12208 raft_consensus.cc:388] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
16:04:46.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.498813 12208 raft_consensus.cc:482] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
16:04:46.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.498847 12208 raft_consensus.cc:3037] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [term 0 FOLLOWER]: Advancing to term 1
16:04:46.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.499579 12208 raft_consensus.cc:504] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "157e22e3e3d04a829df9fd23c036a1a4" member_type: VOTER last_known_addr { host: "127.11.45.131" port: 42623 } }
16:04:46.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.499686 12208 leader_election.cc:302] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [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: 157e22e3e3d04a829df9fd23c036a1a4; no voters: 
16:04:46.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.499874 12208 leader_election.cc:288] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [CANDIDATE]: Term 1 election: Requested vote from peers 
16:04:46.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.499895 12210 raft_consensus.cc:2781] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [term 1 FOLLOWER]: Leader election won for term 1
16:04:46.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.500135 12210 raft_consensus.cc:686] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [term 1 LEADER]: Becoming Leader. State: Replica: 157e22e3e3d04a829df9fd23c036a1a4, State: Running, Role: LEADER
16:04:46.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.500262 12208 ts_tablet_manager.cc:1428] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4: Time spent starting tablet: real 0.005s	user 0.005s	sys 0.000s
16:04:46.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.500419 12210 consensus_queue.cc:237] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 [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: "157e22e3e3d04a829df9fd23c036a1a4" member_type: VOTER last_known_addr { host: "127.11.45.131" port: 42623 } }
16:04:46.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:46.502344 11560 catalog_manager.cc:5495] T 8bf6d14772f14399b18f2d5e6c2860a3 P 157e22e3e3d04a829df9fd23c036a1a4 reported cstate change: term changed from 0 to 1, leader changed from <none> to 157e22e3e3d04a829df9fd23c036a1a4 (127.11.45.131). New cstate: current_term: 1 leader_uuid: "157e22e3e3d04a829df9fd23c036a1a4" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "157e22e3e3d04a829df9fd23c036a1a4" member_type: VOTER last_known_addr { host: "127.11.45.131" port: 42623 } health_report { overall_health: HEALTHY } } }
16:04:48.546 [INFO - main] (Logging.scala:57) Setting hive.metastore.warehouse.dir ('null') to the value of spark.sql.warehouse.dir ('file:/tmp/dist-test-taskGYRXSD/java/build/dist-test/spark-warehouse').
16:04:48.547 [INFO - main] (Logging.scala:57) Warehouse path is 'file:/tmp/dist-test-taskGYRXSD/java/build/dist-test/spark-warehouse'.
16:04:50.242 [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.
16:04:50.399 [INFO - main] (Logging.scala:57) Checkpoint root /tmp/spark_kudu1381516569259846482 resolved to file:/tmp/spark_kudu1381516569259846482.
16:04:50.488 [INFO - main] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu1381516569259846482/metadata using temp file file:/tmp/spark_kudu1381516569259846482/.metadata.5a9b1bdf-10f8-408e-817e-8395609d4a00.tmp
16:04:50.645 [INFO - main] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu1381516569259846482/.metadata.5a9b1bdf-10f8-408e-817e-8395609d4a00.tmp to file:/tmp/spark_kudu1381516569259846482/metadata
16:04:50.696 [INFO - main] (Logging.scala:57) Starting [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]. Use file:/tmp/spark_kudu1381516569259846482 to store the query checkpoint.
16:04:50.720 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Reading table [org.apache.spark.sql.execution.streaming.MemoryStreamTable@528953ef] from DataSourceV2 named 'memory' [org.apache.spark.sql.execution.streaming.MemoryStreamTableProvider$@36baa978]
16:04:50.738 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Starting new streaming query.
16:04:50.743 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Stream started from {}
16:04:50.832 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Streaming query made progress: {
  "id" : "cf4abc3f-420b-424a-86fa-3cca3ac47d0f",
  "runId" : "855a441c-7e0d-4152-8ede-fedd2289794f",
  "name" : null,
  "timestamp" : "2026-07-08T16:04:50.733Z",
  "batchId" : 0,
  "numInputRows" : 0,
  "inputRowsPerSecond" : 0.0,
  "processedRowsPerSecond" : 0.0,
  "durationMs" : {
    "latestOffset" : 0,
    "triggerExecution" : 21
  },
  "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@166d28f0",
    "numOutputRows" : -1
  }
}
16:04:51.143 [INFO - main] (Logging.scala:57) Code generated in 290.176873 ms
16:04:51.188 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu1381516569259846482/offsets/0 using temp file file:/tmp/spark_kudu1381516569259846482/offsets/.0.7f1cec31-7b4b-4b0c-94b4-3dbe6154c393.tmp
16:04:51.241 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu1381516569259846482/offsets/.0.7f1cec31-7b4b-4b0c-94b4-3dbe6154c393.tmp to file:/tmp/spark_kudu1381516569259846482/offsets/0
16:04:51.242 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Committed offsets for batch 0. Metadata OffsetSeqMetadata(0,1783526691159,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))
16:04:52.448 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Code generated in 59.366185 ms
16:04:52.728 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Starting job: start at StreamingTest.scala:54
16:04:52.753 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Got job 0 (start at StreamingTest.scala:54) with 1 output partitions
16:04:52.753 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Final stage: ResultStage 0 (start at StreamingTest.scala:54)
16:04:52.754 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Parents of final stage: List()
16:04:52.756 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Missing parents: List()
16:04:52.765 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting ResultStage 0 (MapPartitionsRDD[4] at start at StreamingTest.scala:54), which has no missing parents
16:04:52.895 [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)
16:04:52.949 [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)
16:04:52.953 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Added broadcast_0_piece0 in memory on dist-test-slave-2v85.c.gcp-upstream.internal:44699 (size: 7.8 KiB, free: 1993.9 MiB)
16:04:52.957 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Created broadcast 0 from broadcast at DAGScheduler.scala:1388
16:04:52.976 [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))
16:04:52.978 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Adding task set 0.0 with 1 tasks resource profile 0
16:04:53.066 [INFO - dispatcher-event-loop-1] (Logging.scala:57) Starting task 0.0 in stage 0.0 (TID 0) (dist-test-slave-2v85.c.gcp-upstream.internal, executor driver, partition 0, PROCESS_LOCAL, 4803 bytes) taskResourceAssignments Map()
16:04:53.093 [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)
16:04:53.602 [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
16:04:53.608 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table bf2b00236e2641bbaf36365530d87ff2
16:04:53.616 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table bf2b00236e2641bbaf36365530d87ff2
16:04:53.624 [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'
16:04:53.646 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 8bf6d14772f14399b18f2d5e6c2860a3 for table 'simple-test' with partition [<start>, <end>)
16:04:53.651 [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@68eee9e1, flushNotification=Deferred@433121928(state=PENDING, result=null, callback=<none>, errback=<none>)}
16:04:53.646 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299989, tablet=8bf6d14772f14399b18f2d5e6c2860a3@[157e22e3e3d04a829df9fd23c036a1a4(127.11.45.131:42623)[L]]}]
16:04:53.664 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 8bf6d14772f14399b18f2d5e6c2860a3 for table 'simple-test' with partition [<start>, <end>)
16:04:53.664 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=8bf6d14772f14399b18f2d5e6c2860a3@[157e22e3e3d04a829df9fd23c036a1a4(127.11.45.131:42623)[L]]}]
16:04:53.667 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 8bf6d14772f14399b18f2d5e6c2860a3 for table 'simple-test' with partition [<start>, <end>)
16:04:53.667 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=8bf6d14772f14399b18f2d5e6c2860a3@[157e22e3e3d04a829df9fd23c036a1a4(127.11.45.131:42623)[L]]}]
16:04:53.680 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 157e22e3e3d04a829df9fd23c036a1a4(127.11.45.131:42623)] connecting to peer
16:04:53.683 [DEBUG - kudu-nio-1] (Connection.java:757) [peer 157e22e3e3d04a829df9fd23c036a1a4(127.11.45.131:42623)] Successfully connected to peer
16:04:53.719 [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
16:04:53.723 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x8bcd1511, L:/127.0.0.1:42460 - R:/127.11.45.131:42623] using TOKEN/null
16:04:53.762 [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 132ms
16:04:53.792 [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). 6756 bytes result sent to driver
16:04:53.809 [INFO - task-result-getter-0] (Logging.scala:57) Finished task 0.0 in stage 0.0 (TID 0) in 762 ms on dist-test-slave-2v85.c.gcp-upstream.internal (executor driver) (1/1)
16:04:53.812 [INFO - task-result-getter-0] (Logging.scala:57) Removed TaskSet 0.0, whose tasks have all completed, from pool 
16:04:53.847 [INFO - dag-scheduler-event-loop] (Logging.scala:57) ResultStage 0 (start at StreamingTest.scala:54) finished in 1.060 s
16:04:53.854 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Job 0 is finished. Cancelling potential speculative or zombie tasks for this job
16:04:53.855 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Killing all running tasks in stage 0: Stage finished
16:04:53.859 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Job 0 finished: start at StreamingTest.scala:54, took 1.130096 s
16:04:53.863 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (KuduContext.scala:445) completed upsert ops: duration histogram: 132ms
16:04:53.903 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu1381516569259846482/commits/0 using temp file file:/tmp/spark_kudu1381516569259846482/commits/.0.3dc8be3b-c652-4c72-a4db-5c047ceeafe5.tmp
16:04:53.929 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu1381516569259846482/commits/.0.3dc8be3b-c652-4c72-a4db-5c047ceeafe5.tmp to file:/tmp/spark_kudu1381516569259846482/commits/0
16:04:53.949 [INFO - stream execution thread for [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f]] (Logging.scala:57) Streaming query made progress: {
  "id" : "cf4abc3f-420b-424a-86fa-3cca3ac47d0f",
  "runId" : "855a441c-7e0d-4152-8ede-fedd2289794f",
  "name" : null,
  "timestamp" : "2026-07-08T16:04:51.153Z",
  "batchId" : 0,
  "numInputRows" : 3,
  "inputRowsPerSecond" : 250.0,
  "processedRowsPerSecond" : 1.079913606911447,
  "durationMs" : {
    "addBatch" : 1958,
    "getBatch" : 3,
    "latestOffset" : 0,
    "queryPlanning" : 654,
    "triggerExecution" : 2778,
    "walCommit" : 82
  },
  "stateOperators" : [ ],
  "sources" : [ {
    "description" : "MemoryStream[value#1]",
    "startOffset" : null,
    "endOffset" : 0,
    "numInputRows" : 3,
    "inputRowsPerSecond" : 250.0,
    "processedRowsPerSecond" : 1.079913606911447
  } ],
  "sink" : {
    "description" : "org.apache.kudu.spark.kudu.KuduSink@166d28f0",
    "numOutputRows" : -1
  }
}
16:04:53.973 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table bf2b00236e2641bbaf36365530d87ff2
16:04:54.113 [INFO - main] (Logging.scala:57) Code generated in 16.155373 ms
16:04:54.241 [INFO - main] (Logging.scala:57) Starting job: collect at StreamingTest.scala:60
16:04:54.243 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Got job 1 (collect at StreamingTest.scala:60) with 1 output partitions
16:04:54.243 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Final stage: ResultStage 1 (collect at StreamingTest.scala:60)
16:04:54.243 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Parents of final stage: List()
16:04:54.243 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Missing parents: List()
16:04:54.248 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting ResultStage 1 (MapPartitionsRDD[11] at map at StreamingTest.scala:60), which has no missing parents
16:04:54.259 [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)
16:04:54.263 [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)
16:04:54.264 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Added broadcast_1_piece0 in memory on dist-test-slave-2v85.c.gcp-upstream.internal:44699 (size: 9.1 KiB, free: 1993.9 MiB)
16:04:54.265 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Created broadcast 1 from broadcast at DAGScheduler.scala:1388
16:04:54.266 [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))
16:04:54.266 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Adding task set 1.0 with 1 tasks resource profile 0
16:04:54.276 [INFO - dispatcher-event-loop-0] (Logging.scala:57) Starting task 0.0 in stage 1.0 (TID 1) (dist-test-slave-2v85.c.gcp-upstream.internal, executor driver, partition 0, ANY, 4798 bytes) taskResourceAssignments Map()
16:04:54.277 [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)
16:04:54.381 [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
16:04:54.427 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Code generated in 12.030449 ms
16:04:54.473 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305325340502249472) for scanner KuduScanner(table=simple-test, tablet=8bf6d14772f14399b18f2d5e6c2860a3, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:04:54.554 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Code generated in 63.12912 ms
16:04:54.560 [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). 5416 bytes result sent to driver
16:04:54.569 [INFO - task-result-getter-1] (Logging.scala:57) Finished task 0.0 in stage 1.0 (TID 1) in 293 ms on dist-test-slave-2v85.c.gcp-upstream.internal (executor driver) (1/1)
16:04:54.569 [INFO - task-result-getter-1] (Logging.scala:57) Removed TaskSet 1.0, whose tasks have all completed, from pool 
16:04:54.571 [INFO - dag-scheduler-event-loop] (Logging.scala:57) ResultStage 1 (collect at StreamingTest.scala:60) finished in 0.317 s
16:04:54.571 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Job 1 is finished. Cancelling potential speculative or zombie tasks for this job
16:04:54.571 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Killing all running tasks in stage 1: Stage finished
16:04:54.572 [INFO - main] (Logging.scala:57) Job 1 finished: collect at StreamingTest.scala:60, took 0.330130 s
16:04:54.576 [INFO - main] (Logging.scala:57) Asked to cancel job group 855a441c-7e0d-4152-8ede-fedd2289794f
16:04:54.600 [INFO - main] (Logging.scala:57) Asked to cancel job group 855a441c-7e0d-4152-8ede-fedd2289794f
16:04:54.602 [INFO - main] (Logging.scala:57) Query [id = cf4abc3f-420b-424a-86fa-3cca3ac47d0f, runId = 855a441c-7e0d-4152-8ede-fedd2289794f] was stopped
16:04:54.632 [INFO - dispatcher-event-loop-0] (Logging.scala:57) MapOutputTrackerMasterEndpoint stopped!
16:04:54.652 [INFO - main] (Logging.scala:57) MemoryStore cleared
16:04:54.653 [INFO - main] (Logging.scala:57) BlockManager stopped
16:04:54.666 [INFO - main] (Logging.scala:57) BlockManagerMaster stopped
16:04:54.672 [INFO - dispatcher-event-loop-1] (Logging.scala:57) OutputCommitCoordinator stopped!
16:04:54.680 [INFO - main] (Logging.scala:57) Successfully stopped SparkContext
16:04:54.686 [DEBUG - main] (Connection.java:575) [peer master-127.11.45.190:42895(127.11.45.190:42895)] disconnecting while in state READY
16:04:54.688 [DEBUG - main] (Connection.java:575) [peer 157e22e3e3d04a829df9fd23c036a1a4(127.11.45.131:42623)] disconnecting while in state READY
16:04:54.688 [DEBUG - main] (Connection.java:575) [peer master-127.11.45.188:35349(127.11.45.188:35349)] disconnecting while in state READY
16:04:54.689 [DEBUG - main] (Connection.java:575) [peer master-127.11.45.189:33751(127.11.45.189:33751)] disconnecting while in state READY
16:04:54.698 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2704) Releasing all remaining resources
16:04:54.699 [DEBUG - kudu-nio-1] (Connection.java:239) [peer 157e22e3e3d04a829df9fd23c036a1a4(127.11.45.131:42623)] handling channelInactive
16:04:54.700 [DEBUG - kudu-nio-1] (Connection.java:709) [peer 157e22e3e3d04a829df9fd23c036a1a4(127.11.45.131:42623)] cleaning up while in state READY due to: connection closed
16:04:54.701 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.11.45.188:35349(127.11.45.188:35349)] handling channelInactive
16:04:54.701 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.11.45.188:35349(127.11.45.188:35349)] cleaning up while in state READY due to: connection closed
16:04:54.703 [DEBUG - kudu-nio-1] (PoolThreadCache.java:221) Freed 22 thread-local buffer(s) from thread: kudu-nio-1
16:04:54.704 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.11.45.190:42895(127.11.45.190:42895)] handling channelInactive
16:04:54.704 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.11.45.190:42895(127.11.45.190:42895)] cleaning up while in state READY due to: connection closed
16:04:54.705 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.11.45.189:33751(127.11.45.189:33751)] handling channelInactive
16:04:54.706 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.11.45.189:33751(127.11.45.189:33751)] cleaning up while in state READY due to: connection closed
16:04:54.707 [DEBUG - kudu-nio-0] (PoolThreadCache.java:221) Freed 31 thread-local buffer(s) from thread: kudu-nio-0
16:04:54.722 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
16:04:54.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:54.724323 11446 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskGYRXSD/build/release/bin/kudu with pid 11730
16:04:54.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:54.731155 11446 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskGYRXSD/build/release/bin/kudu with pid 11868
16:04:54.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:54.738127 11446 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskGYRXSD/build/release/bin/kudu with pid 12003
16:04:54.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:54.745167 11446 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskGYRXSD/build/release/bin/kudu with pid 11457
16:04:54.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:54.752746 11446 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskGYRXSD/build/release/bin/kudu with pid 11528
16:04:54.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 16:04:54.758410 11446 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskGYRXSD/build/release/bin/kudu with pid 11598
16:04:54.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T16:04:54Z chronyd exiting

Time: 15.456

OK (1 test)

16:04:55.082 [INFO - shutdown-hook-0] (Logging.scala:57) Shutdown hook called
16:04:55.083 [INFO - shutdown-hook-0] (Logging.scala:57) Deleting directory /tmp/spark-6d2d3e65-679e-4f89-8176-1970756ae830
