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

22:21:53.663 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
22:21:53.671 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

22:21:53.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.672588  2110 mini_oidc.cc:152] Starting JWKS server
22:21:53.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.675035  2110 webserver.cc:460] Webserver started at http://127.0.0.1:35757/ using document root <none> and password file <none>
22:21:53.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.675169  2110 mini_oidc.cc:189] Starting OIDC Discovery server
22:21:53.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.675472  2110 webserver.cc:460] Webserver started at http://127.0.0.1:34333/ using document root <none> and password file <none>
22:21:53.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T22:21:53Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
22:21:53.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T22:21:53Z Disabled control of system clock
22:21:53.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.693085  2110 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:53.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:53.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/wal
22:21:53.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/data
22:21:53.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
22:21:53.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
22:21:53.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
22:21:53.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:53.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:53.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:53.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/logs
22:21:53.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/data/info.pb
22:21:53.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:53.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
22:21:53.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
22:21:53.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
22:21:53.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
22:21:53.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:53.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:53.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:53.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
22:21:53.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
22:21:53.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
22:21:53.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
22:21:53.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.190:44541
22:21:53.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.190
22:21:53.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:53.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:53.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:53.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:53.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:21:53.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
22:21:53.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:53.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
22:21:53.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35757/jwks.json with env {}
22:21:53.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.804616  2121 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
22:21:53.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.804903  2121 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
22:21:53.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.804940  2121 flags.cc:425] Enabled unsafe flag: --never_fsync=true
22:21:53.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.809190  2121 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
22:21:53.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.809252  2121 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
22:21:53.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.809270  2121 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
22:21:53.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.809286  2121 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
22:21:53.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.809302  2121 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
22:21:53.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.809316  2121 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:35757/jwks.json
22:21:53.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.814105  2121 master_runner.cc:386] Master server non-default flags:
22:21:53.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:53.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:53.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:53.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:21:53.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/data
22:21:53.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/wal
22:21:53.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
22:21:53.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:53.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:53.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:53.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
22:21:53.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.190:44541
22:21:53.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35757/jwks.json
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/data/info.pb
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.190
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.2121
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:53.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/logs
22:21:53.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:53.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
22:21:53.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
22:21:53.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
22:21:53.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
22:21:53.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
22:21:53.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
22:21:53.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 21:46:50 UTC on ccycloud.quasar-irklax.root.comops.site
22:21:53.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492326
22:21:53.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.815403  2121 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
22:21:53.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.817203  2121 file_cache.cc:493] Constructed file cache file cache with capacity 419430
22:21:53.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.826682  2121 server_base.cc:1034] running on GCE node
22:21:53.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.826766  2127 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
22:21:53.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.826682  2126 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
22:21:53.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.826673  2129 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
22:21:53.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.828212  2121 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
22:21:53.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.829355  2121 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
22:21:53.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.830528  2121 hybrid_clock.cc:648] HybridClock initialized: now 1783462913830480 us; error 67 us; skew 500 ppm
22:21:53.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.832549  2121 webserver.cc:460] Webserver started at http://127.2.15.190:36157/ using document root <none> and password file <none>
22:21:53.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.833240  2121 fs_manager.cc:359] Metadata directory not provided
22:21:53.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.833330  2121 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
22:21:53.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.833556  2121 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
22:21:53.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.835635  2121 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/data/instance:
22:21:53.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b0c2cf18bfc246929917a73fc7351ade"
22:21:53.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:53 on dist-test-slave-x101"
22:21:53.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.836182  2121 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/wal/instance:
22:21:53.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b0c2cf18bfc246929917a73fc7351ade"
22:21:53.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:53 on dist-test-slave-x101"
22:21:53.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.841113  2121 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.004s	sys 0.000s
22:21:53.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.844234  2135 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
22:21:53.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.845750  2121 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
22:21:53.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.845852  2121 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/data,/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/wal
22:21:53.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b0c2cf18bfc246929917a73fc7351ade"
22:21:53.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:53 on dist-test-slave-x101"
22:21:53.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.845932  2121 fs_report.cc:383] FS layout report
22:21:53.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
22:21:53.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/wal
22:21:53.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/wal
22:21:53.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/data/data
22:21:53.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
22:21:53.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
22:21:53.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
22:21:53.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
22:21:53.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
22:21:53.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
22:21:53.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
22:21:53.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
22:21:53.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
22:21:53.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
22:21:53.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
22:21:53.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.861572  2121 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
22:21:53.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.862219  2121 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
22:21:53.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.862376  2121 kserver.cc:163] Server-wide thread pool size limit: 3276
22:21:53.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.869562  2121 rpc_server.cc:307] RPC server started. Bound to: 127.2.15.190:44541
22:21:53.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.869583  2187 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.15.190:44541 every 8 connection(s)
22:21:53.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.870442  2121 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/data/info.pb
22:21:53.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.873803  2188 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
22:21:53.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.877421  2188 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } has no permanent_uuid. Determining permanent_uuid...
22:21:53.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.879547  2110 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskz_BPic/build/debug/bin/kudu as pid 2121
22:21:53.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.879778  2110 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-0/wal/instance
22:21:53.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.881491  2110 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:53.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:53.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/wal
22:21:53.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/data
22:21:53.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
22:21:53.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
22:21:53.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
22:21:53.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:53.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:53.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:53.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/logs
22:21:53.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/data/info.pb
22:21:53.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
22:21:53.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.189:33075
22:21:53.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.189
22:21:53.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:53.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:53.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:53.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:53.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:21:53.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
22:21:53.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:53.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
22:21:53.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35757/jwks.json with env {}
22:21:53.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.892951  2188 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } has no permanent_uuid. Determining permanent_uuid...
22:21:53.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.893831  2137 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.2.15.189:33075: connect: Connection refused (error 111)
22:21:53.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.894731  2188 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.15.189:33075: Network error: Client connection negotiation failed: client connection to 127.2.15.189:33075: connect: Connection refused (error 111)
22:21:53.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:53.944032  2188 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } attempt: 1
22:21:53.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.945771  2188 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.15.189:33075: Network error: Client connection negotiation failed: client connection to 127.2.15.189:33075: connect: Connection refused (error 111)
22:21:53.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.995596  2192 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
22:21:53.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.995915  2192 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
22:21:53.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:53.995975  2192 flags.cc:425] Enabled unsafe flag: --never_fsync=true
22:21:54.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.000398  2192 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
22:21:54.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.000479  2192 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
22:21:54.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.000505  2192 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
22:21:54.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.000530  2192 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
22:21:54.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.000552  2192 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
22:21:54.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.000571  2192 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:35757/jwks.json
22:21:54.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.005468  2192 master_runner.cc:386] Master server non-default flags:
22:21:54.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/data
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/wal
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.189:33075
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
22:21:54.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35757/jwks.json
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/data/info.pb
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.189
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.2192
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
22:21:54.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:54.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/logs
22:21:54.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:54.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
22:21:54.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
22:21:54.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
22:21:54.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
22:21:54.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
22:21:54.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
22:21:54.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 21:46:50 UTC on ccycloud.quasar-irklax.root.comops.site
22:21:54.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492326
22:21:54.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.006947  2192 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
22:21:54.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.008818  2192 file_cache.cc:493] Constructed file cache file cache with capacity 419430
22:21:54.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.013949  2188 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } attempt: 2
22:21:54.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.015463  2188 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.15.189:33075: Network error: Client connection negotiation failed: client connection to 127.2.15.189:33075: connect: Connection refused (error 111)
22:21:54.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.017751  2201 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
22:21:54.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.017760  2199 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
22:21:54.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.017948  2198 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
22:21:54.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.018224  2192 server_base.cc:1034] running on GCE node
22:21:54.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.018903  2192 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
22:21:54.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.020323  2192 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
22:21:54.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.021488  2192 hybrid_clock.cc:648] HybridClock initialized: now 1783462914021459 us; error 45 us; skew 500 ppm
22:21:54.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.023784  2192 webserver.cc:460] Webserver started at http://127.2.15.189:43125/ using document root <none> and password file <none>
22:21:54.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.024317  2192 fs_manager.cc:359] Metadata directory not provided
22:21:54.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.024376  2192 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
22:21:54.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.024536  2192 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
22:21:54.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.026408  2192 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/data/instance:
22:21:54.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6f68e4ac85cb4b8084598ff1fca7204c"
22:21:54.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:54 on dist-test-slave-x101"
22:21:54.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.026998  2192 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/wal/instance:
22:21:54.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6f68e4ac85cb4b8084598ff1fca7204c"
22:21:54.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:54 on dist-test-slave-x101"
22:21:54.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.031102  2192 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.006s	sys 0.000s
22:21:54.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.033771  2207 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
22:21:54.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.035158  2192 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
22:21:54.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.035322  2192 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/data,/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/wal
22:21:54.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6f68e4ac85cb4b8084598ff1fca7204c"
22:21:54.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:54 on dist-test-slave-x101"
22:21:54.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.035427  2192 fs_report.cc:383] FS layout report
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/wal
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/wal
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/data/data
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
22:21:54.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
22:21:54.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
22:21:54.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
22:21:54.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
22:21:54.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.049098  2192 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
22:21:54.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.049860  2192 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
22:21:54.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.050084  2192 kserver.cc:163] Server-wide thread pool size limit: 3276
22:21:54.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.057281  2192 rpc_server.cc:307] RPC server started. Bound to: 127.2.15.189:33075
22:21:54.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.057452  2259 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.15.189:33075 every 8 connection(s)
22:21:54.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.058323  2192 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/data/info.pb
22:21:54.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.061606  2260 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
22:21:54.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.064957  2260 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } has no permanent_uuid. Determining permanent_uuid...
22:21:54.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.067734  2110 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskz_BPic/build/debug/bin/kudu as pid 2192
22:21:54.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.067837  2110 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-1/wal/instance
22:21:54.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.068419  2110 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:54.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:54.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/wal
22:21:54.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/data
22:21:54.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
22:21:54.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/logs
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/data/info.pb
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
22:21:54.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.188:35115
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.188
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
22:21:54.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35757/jwks.json with env {}
22:21:54.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.077616  2260 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } has no permanent_uuid. Determining permanent_uuid...
22:21:54.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.085310  2260 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } has no permanent_uuid. Determining permanent_uuid...
22:21:54.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.086112  2209 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.2.15.188:35115: connect: Connection refused (error 111)
22:21:54.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.087001  2260 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.15.188:35115: Network error: Client connection negotiation failed: client connection to 127.2.15.188:35115: connect: Connection refused (error 111)
22:21:54.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.106666  2188 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } attempt: 3
22:21:54.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.111702  2188 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } has no permanent_uuid. Determining permanent_uuid...
22:21:54.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.113076  2188 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.15.188:35115: Network error: Client connection negotiation failed: client connection to 127.2.15.188:35115: connect: Connection refused (error 111)
22:21:54.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.136252  2260 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } attempt: 1
22:21:54.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.137825  2260 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.15.188:35115: Network error: Client connection negotiation failed: client connection to 127.2.15.188:35115: connect: Connection refused (error 111)
22:21:54.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.144253  2188 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } attempt: 1
22:21:54.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.145678  2188 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.15.188:35115: Network error: Client connection negotiation failed: client connection to 127.2.15.188:35115: connect: Connection refused (error 111)
22:21:54.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.187889  2263 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
22:21:54.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.188163  2263 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
22:21:54.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.188201  2263 flags.cc:425] Enabled unsafe flag: --never_fsync=true
22:21:54.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.192231  2263 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
22:21:54.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.192287  2263 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
22:21:54.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.192304  2263 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
22:21:54.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.192320  2263 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
22:21:54.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.192335  2263 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
22:21:54.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.192349  2263 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:35757/jwks.json
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.196988  2263 master_runner.cc:386] Master server non-default flags:
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/data
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/wal
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.188:35115
22:21:54.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35757/jwks.json
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/data/info.pb
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.188
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.2263
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/logs
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:54.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
22:21:54.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
22:21:54.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
22:21:54.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
22:21:54.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
22:21:54.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
22:21:54.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 21:46:50 UTC on ccycloud.quasar-irklax.root.comops.site
22:21:54.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492326
22:21:54.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.198261  2263 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
22:21:54.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.200090  2263 file_cache.cc:493] Constructed file cache file cache with capacity 419430
22:21:54.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.206027  2260 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } attempt: 2
22:21:54.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.207736  2260 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.15.188:35115: Network error: Client connection negotiation failed: client connection to 127.2.15.188:35115: connect: Connection refused (error 111)
22:21:54.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.211006  2270 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
22:21:54.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.211220  2263 server_base.cc:1034] running on GCE node
22:21:54.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.211020  2271 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
22:21:54.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.211045  2273 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
22:21:54.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.212450  2263 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
22:21:54.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.213928  2263 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
22:21:54.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.215421  2263 hybrid_clock.cc:648] HybridClock initialized: now 1783462914215357 us; error 78 us; skew 500 ppm
22:21:54.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.217334  2263 webserver.cc:460] Webserver started at http://127.2.15.188:39479/ using document root <none> and password file <none>
22:21:54.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.217955  2263 fs_manager.cc:359] Metadata directory not provided
22:21:54.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.218021  2263 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
22:21:54.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.218189  2263 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
22:21:54.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.220371  2263 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/data/instance:
22:21:54.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "62fdbfca93b14d779fb35d303305752c"
22:21:54.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:54 on dist-test-slave-x101"
22:21:54.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.220906  2263 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/wal/instance:
22:21:54.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "62fdbfca93b14d779fb35d303305752c"
22:21:54.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:54 on dist-test-slave-x101"
22:21:54.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.220891  2188 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } attempt: 2
22:21:54.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.222285  2188 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.15.188:35115: Network error: Client connection negotiation failed: client connection to 127.2.15.188:35115: connect: Connection refused (error 111)
22:21:54.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.225200  2263 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
22:21:54.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.227754  2279 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
22:21:54.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.229091  2263 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
22:21:54.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.229195  2263 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/data,/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/wal
22:21:54.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "62fdbfca93b14d779fb35d303305752c"
22:21:54.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:54 on dist-test-slave-x101"
22:21:54.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.229328  2263 fs_report.cc:383] FS layout report
22:21:54.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
22:21:54.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/wal
22:21:54.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/wal
22:21:54.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/data/data
22:21:54.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
22:21:54.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
22:21:54.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
22:21:54.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
22:21:54.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
22:21:54.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
22:21:54.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
22:21:54.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
22:21:54.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
22:21:54.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
22:21:54.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
22:21:54.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.247893  2263 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
22:21:54.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.248575  2263 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
22:21:54.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.248735  2263 kserver.cc:163] Server-wide thread pool size limit: 3276
22:21:54.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.256006  2263 rpc_server.cc:307] RPC server started. Bound to: 127.2.15.188:35115
22:21:54.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.256058  2331 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.15.188:35115 every 8 connection(s)
22:21:54.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.257058  2263 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/data/info.pb
22:21:54.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.260816  2332 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
22:21:54.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.264366  2332 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } has no permanent_uuid. Determining permanent_uuid...
22:21:54.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.265046  2110 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskz_BPic/build/debug/bin/kudu as pid 2263
22:21:54.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.265163  2110 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/master-2/wal/instance
22:21:54.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.275954  2332 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } has no permanent_uuid. Determining permanent_uuid...
22:21:54.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.281936  2332 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } has no permanent_uuid. Determining permanent_uuid...
22:21:54.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.289764  2332 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c: Bootstrap starting.
22:21:54.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.292634  2332 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c: Neither blocks nor log segments found. Creating new log.
22:21:54.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.293565  2332 log.cc:824] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c: Log is configured to *not* fsync() on all Append() calls
22:21:54.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.295542  2332 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c: No bootstrap required, opened a new log
22:21:54.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.298892  2260 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } attempt: 3
22:21:54.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.298877  2332 raft_consensus.cc:348] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } }
22:21:54.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.299053  2332 raft_consensus.cc:374] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
22:21:54.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.299118  2332 raft_consensus.cc:729] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 62fdbfca93b14d779fb35d303305752c, State: Initialized, Role: FOLLOWER
22:21:54.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.299642  2332 consensus_queue.cc:260] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [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: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } }
22:21:54.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.300508  2341 sys_catalog.cc:455] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [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: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } } }
22:21:54.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.300832  2341 sys_catalog.cc:458] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [sys.catalog]: This master's current role is: FOLLOWER
22:21:54.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.301075  2332 sys_catalog.cc:564] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [sys.catalog]: configured and running, proceeding with master startup.
22:21:54.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.307428  2260 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c: Bootstrap starting.
22:21:54.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.307454  2352 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
22:21:54.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.307544  2352 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
22:21:54.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.305178  2263 master_runner.cc:186] Error getting master registration for 127.2.15.190:44541: OK, instance_id { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" instance_seqno: 1783462913867686 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
22:21:54.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.308514  2263 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
22:21:54.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.310084  2260 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c: Neither blocks nor log segments found. Creating new log.
22:21:54.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.311273  2260 log.cc:824] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c: Log is configured to *not* fsync() on all Append() calls
22:21:54.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.312948  2260 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c: No bootstrap required, opened a new log
22:21:54.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.316167  2260 raft_consensus.cc:348] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } }
22:21:54.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.316375  2260 raft_consensus.cc:374] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
22:21:54.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.316421  2260 raft_consensus.cc:729] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6f68e4ac85cb4b8084598ff1fca7204c, State: Initialized, Role: FOLLOWER
22:21:54.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.316906  2260 consensus_queue.cc:260] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [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: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } }
22:21:54.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.317806  2355 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [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: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } } }
22:21:54.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.317926  2355 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [sys.catalog]: This master's current role is: FOLLOWER
22:21:54.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.318280  2260 sys_catalog.cc:564] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [sys.catalog]: configured and running, proceeding with master startup.
22:21:54.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.321461  2188 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } attempt: 3
22:21:54.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.323987  2366 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
22:21:54.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.324275  2366 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
22:21:54.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.322628  2192 master_runner.cc:186] Error getting master registration for 127.2.15.190:44541: OK, instance_id { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" instance_seqno: 1783462913867686 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
22:21:54.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.326141  2192 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
22:21:54.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.330631  2188 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade: Bootstrap starting.
22:21:54.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.333634  2188 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade: Neither blocks nor log segments found. Creating new log.
22:21:54.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.334915  2188 log.cc:824] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade: Log is configured to *not* fsync() on all Append() calls
22:21:54.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.337888  2188 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade: No bootstrap required, opened a new log
22:21:54.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.342275  2188 raft_consensus.cc:348] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } }
22:21:54.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.342515  2188 raft_consensus.cc:374] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
22:21:54.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.342569  2188 raft_consensus.cc:729] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b0c2cf18bfc246929917a73fc7351ade, State: Initialized, Role: FOLLOWER
22:21:54.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.343096  2188 consensus_queue.cc:260] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [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: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } }
22:21:54.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.343658  2369 sys_catalog.cc:455] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [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: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } } }
22:21:54.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.343963  2369 sys_catalog.cc:458] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [sys.catalog]: This master's current role is: FOLLOWER
22:21:54.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.344707  2188 sys_catalog.cc:564] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [sys.catalog]: configured and running, proceeding with master startup.
22:21:54.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.352142  2380 catalog_manager.cc:1558] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
22:21:54.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.352495  2380 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
22:21:54.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.353780  2121 master_runner.cc:263] No leader master found from master b0c2cf18bfc246929917a73fc7351ade
22:21:54.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.353838  2121 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
22:21:54.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.364023  2141 tablet.cc:2369] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade: Can't schedule compaction. Clean time has not been advanced past its initial value.
22:21:54.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.500146  2285 tablet.cc:2369] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c: Can't schedule compaction. Clean time has not been advanced past its initial value.
22:21:54.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.551739  2213 tablet.cc:2369] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c: Can't schedule compaction. Clean time has not been advanced past its initial value.
22:21:54.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.721640  2341 raft_consensus.cc:482] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
22:21:54.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.721892  2341 raft_consensus.cc:504] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } }
22:21:54.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.723001  2341 leader_election.cc:288] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers b0c2cf18bfc246929917a73fc7351ade (127.2.15.190:44541), 6f68e4ac85cb4b8084598ff1fca7204c (127.2.15.189:33075)
22:21:54.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.723626  2162 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "62fdbfca93b14d779fb35d303305752c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b0c2cf18bfc246929917a73fc7351ade" is_pre_election: true
22:21:54.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.723685  2234 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "62fdbfca93b14d779fb35d303305752c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" is_pre_election: true
22:21:54.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.723938  2234 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 62fdbfca93b14d779fb35d303305752c in term 0.
22:21:54.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.723992  2162 raft_consensus.cc:2454] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 62fdbfca93b14d779fb35d303305752c in term 0.
22:21:54.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.724344  2281 leader_election.cc:302] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [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: 62fdbfca93b14d779fb35d303305752c, 6f68e4ac85cb4b8084598ff1fca7204c; no voters: 
22:21:54.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.724671  2341 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [term 0 FOLLOWER]: Leader pre-election won for term 1
22:21:54.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.724756  2341 raft_consensus.cc:482] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
22:21:54.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.724788  2341 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [term 0 FOLLOWER]: Advancing to term 1
22:21:54.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.725718  2341 raft_consensus.cc:504] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } }
22:21:54.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.726094  2341 leader_election.cc:288] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [CANDIDATE]: Term 1 election: Requested vote from peers b0c2cf18bfc246929917a73fc7351ade (127.2.15.190:44541), 6f68e4ac85cb4b8084598ff1fca7204c (127.2.15.189:33075)
22:21:54.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.726359  2162 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "62fdbfca93b14d779fb35d303305752c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b0c2cf18bfc246929917a73fc7351ade"
22:21:54.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.726506  2162 raft_consensus.cc:3037] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [term 0 FOLLOWER]: Advancing to term 1
22:21:54.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.726536  2234 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "62fdbfca93b14d779fb35d303305752c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6f68e4ac85cb4b8084598ff1fca7204c"
22:21:54.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.726740  2234 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [term 0 FOLLOWER]: Advancing to term 1
22:21:54.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.727768  2162 raft_consensus.cc:2454] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 62fdbfca93b14d779fb35d303305752c in term 1.
22:21:54.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.728088  2234 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 62fdbfca93b14d779fb35d303305752c in term 1.
22:21:54.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.728123  2283 leader_election.cc:302] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [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: 62fdbfca93b14d779fb35d303305752c, b0c2cf18bfc246929917a73fc7351ade; no voters: 
22:21:54.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.728302  2341 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [term 1 FOLLOWER]: Leader election won for term 1
22:21:54.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.728498  2341 raft_consensus.cc:686] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [term 1 LEADER]: Becoming Leader. State: Replica: 62fdbfca93b14d779fb35d303305752c, State: Running, Role: LEADER
22:21:54.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.728914  2341 consensus_queue.cc:237] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [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: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } }
22:21:54.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.730923  2382 sys_catalog.cc:455] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [sys.catalog]: SysCatalogTable state changed. Reason: New leader 62fdbfca93b14d779fb35d303305752c. Latest consensus state: current_term: 1 leader_uuid: "62fdbfca93b14d779fb35d303305752c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } } }
22:21:54.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.731038  2382 sys_catalog.cc:458] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [sys.catalog]: This master's current role is: LEADER
22:21:54.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.731832  2384 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
22:21:54.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.732935  2384 catalog_manager.cc:1484] Initializing Kudu cluster ID...
22:21:54.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.738646  2162 raft_consensus.cc:1261] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [term 1 FOLLOWER]: Refusing update from remote peer 62fdbfca93b14d779fb35d303305752c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
22:21:54.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.738646  2234 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [term 1 FOLLOWER]: Refusing update from remote peer 62fdbfca93b14d779fb35d303305752c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
22:21:54.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.739282  2341 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [LEADER]: Connected to new peer: Peer: permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
22:21:54.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.739441  2382 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [LEADER]: Connected to new peer: Peer: permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
22:21:54.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.743556  2355 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [sys.catalog]: SysCatalogTable state changed. Reason: New leader 62fdbfca93b14d779fb35d303305752c. Latest consensus state: current_term: 1 leader_uuid: "62fdbfca93b14d779fb35d303305752c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } } }
22:21:54.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.743696  2355 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [sys.catalog]: This master's current role is: FOLLOWER
22:21:54.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.743674  2369 sys_catalog.cc:455] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [sys.catalog]: SysCatalogTable state changed. Reason: New leader 62fdbfca93b14d779fb35d303305752c. Latest consensus state: current_term: 1 leader_uuid: "62fdbfca93b14d779fb35d303305752c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } } }
22:21:54.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.743803  2369 sys_catalog.cc:458] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [sys.catalog]: This master's current role is: FOLLOWER
22:21:54.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.746912  2341 sys_catalog.cc:455] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "62fdbfca93b14d779fb35d303305752c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } } }
22:21:54.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.747046  2341 sys_catalog.cc:458] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [sys.catalog]: This master's current role is: LEADER
22:21:54.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.747167  2341 sys_catalog.cc:455] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "62fdbfca93b14d779fb35d303305752c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } } }
22:21:54.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.747237  2341 sys_catalog.cc:458] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c [sys.catalog]: This master's current role is: LEADER
22:21:54.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.747340  2355 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "62fdbfca93b14d779fb35d303305752c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } } }
22:21:54.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.747457  2355 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c [sys.catalog]: This master's current role is: FOLLOWER
22:21:54.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.749120  2369 sys_catalog.cc:455] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "62fdbfca93b14d779fb35d303305752c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b0c2cf18bfc246929917a73fc7351ade" member_type: VOTER last_known_addr { host: "127.2.15.190" port: 44541 } } peers { permanent_uuid: "6f68e4ac85cb4b8084598ff1fca7204c" member_type: VOTER last_known_addr { host: "127.2.15.189" port: 33075 } } peers { permanent_uuid: "62fdbfca93b14d779fb35d303305752c" member_type: VOTER last_known_addr { host: "127.2.15.188" port: 35115 } } }
22:21:54.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.749204  2387 mvcc.cc:205] Tried to move back new op lower bound from 7305064098761756672 to 7305064098732539904. Current Snapshot: MvccSnapshot[applied={T|T < 7305064098761756672}]
22:21:54.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.749223  2384 catalog_manager.cc:1347] Generated new cluster ID: 1afc5abcf95e4ff281278893503e4900
22:21:54.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.749267  2369 sys_catalog.cc:458] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade [sys.catalog]: This master's current role is: FOLLOWER
22:21:54.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.749291  2384 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
22:21:54.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.763926  2384 catalog_manager.cc:1370] Generated new certificate authority record
22:21:54.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.765221  2384 catalog_manager.cc:1504] Loading token signing keys...
22:21:54.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.774219  2384 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 62fdbfca93b14d779fb35d303305752c: Generated new TSK 0
22:21:54.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.775316  2384 catalog_manager.cc:1514] Initializing in-progress tserver states...
22:21:54.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.804323  2110 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:54.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:54.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/wal
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/data
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/logs
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/data/info.pb
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.129:0
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.15.129
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.129
22:21:54.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:54.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:54.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:54.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:54.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:54.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
22:21:54.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.923947  2394 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
22:21:54.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.924232  2394 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
22:21:54.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.924285  2394 flags.cc:425] Enabled unsafe flag: --never_fsync=true
22:21:54.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.928511  2394 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
22:21:54.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.928651  2394 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.2.15.129
22:21:54.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.933631  2394 tablet_server_runner.cc:78] Tablet server non-default flags:
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/data
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/wal
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.129:0
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/data/info.pb
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.129
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.2394
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.15.129
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/logs
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
22:21:54.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
22:21:54.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
22:21:54.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
22:21:54.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 21:46:50 UTC on ccycloud.quasar-irklax.root.comops.site
22:21:54.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492326
22:21:54.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.935025  2394 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
22:21:54.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.936544  2394 file_cache.cc:493] Constructed file cache file cache with capacity 419430
22:21:54.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.946789  2399 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
22:21:54.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.946815  2402 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
22:21:54.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:54.946991  2400 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
22:21:54.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.947279  2394 server_base.cc:1034] running on GCE node
22:21:54.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.947737  2394 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
22:21:54.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.948414  2394 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
22:21:54.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.951714  2394 hybrid_clock.cc:648] HybridClock initialized: now 1783462914951686 us; error 34 us; skew 500 ppm
22:21:54.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.957439  2394 webserver.cc:460] Webserver started at http://127.2.15.129:33471/ using document root <none> and password file <none>
22:21:54.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.958365  2394 fs_manager.cc:359] Metadata directory not provided
22:21:54.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.958485  2394 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
22:21:54.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.958703  2394 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
22:21:54.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.960973  2394 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/data/instance:
22:21:54.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d308134a0fa24d0182be18f09014218e"
22:21:54.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:54 on dist-test-slave-x101"
22:21:54.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.961505  2394 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/wal/instance:
22:21:54.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d308134a0fa24d0182be18f09014218e"
22:21:54.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:54 on dist-test-slave-x101"
22:21:54.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.966241  2394 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
22:21:54.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.969178  2408 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
22:21:54.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.970628  2394 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
22:21:54.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.970755  2394 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/data,/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/wal
22:21:54.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d308134a0fa24d0182be18f09014218e"
22:21:54.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:54 on dist-test-slave-x101"
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:54.970872  2394 fs_report.cc:383] FS layout report
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/wal
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/wal
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/data/data
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
22:21:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
22:21:55.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.000285  2394 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
22:21:55.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.001946  2394 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
22:21:55.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.002177  2394 kserver.cc:163] Server-wide thread pool size limit: 3276
22:21:55.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.003072  2394 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
22:21:55.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.004516  2394 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
22:21:55.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.004597  2394 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
22:21:55.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.004657  2394 ts_tablet_manager.cc:610] Registered 0 tablets
22:21:55.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.004678  2394 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
22:21:55.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.017496  2394 rpc_server.cc:307] RPC server started. Bound to: 127.2.15.129:35601
22:21:55.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.017495  2521 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.15.129:35601 every 8 connection(s)
22:21:55.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.019084  2394 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/data/info.pb
22:21:55.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.021206  2110 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskz_BPic/build/debug/bin/kudu as pid 2394
22:21:55.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.021333  2110 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-0/wal/instance
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.024952  2110 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/wal
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/data
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/logs
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/data/info.pb
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
22:21:55.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
22:21:55.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
22:21:55.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:55.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:55.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:55.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
22:21:55.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
22:21:55.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.130:0
22:21:55.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.15.130
22:21:55.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.130
22:21:55.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:55.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:55.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:55.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:55.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:55.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
22:21:55.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.033272  2522 heartbeater.cc:347] Connected to a master server at 127.2.15.188:35115
22:21:55.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.033347  2524 heartbeater.cc:347] Connected to a master server at 127.2.15.189:33075
22:21:55.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.033552  2524 heartbeater.cc:464] Registering TS with master...
22:21:55.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.033552  2522 heartbeater.cc:464] Registering TS with master...
22:21:55.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.034255  2524 heartbeater.cc:511] Master 127.2.15.189:33075 requested a full tablet report, sending...
22:21:55.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.034255  2522 heartbeater.cc:511] Master 127.2.15.188:35115 requested a full tablet report, sending...
22:21:55.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.036015  2296 ts_manager.cc:194] Registered new tserver with Master: d308134a0fa24d0182be18f09014218e (127.2.15.129:35601)
22:21:55.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.036015  2223 ts_manager.cc:194] Registered new tserver with Master: d308134a0fa24d0182be18f09014218e (127.2.15.129:35601)
22:21:55.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.037345  2296 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.2.15.129:57995
22:21:55.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.040254  2523 heartbeater.cc:347] Connected to a master server at 127.2.15.190:44541
22:21:55.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.040349  2523 heartbeater.cc:464] Registering TS with master...
22:21:55.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.040566  2523 heartbeater.cc:511] Master 127.2.15.190:44541 requested a full tablet report, sending...
22:21:55.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.041747  2152 ts_manager.cc:194] Registered new tserver with Master: d308134a0fa24d0182be18f09014218e (127.2.15.129:35601)
22:21:55.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.162364  2532 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
22:21:55.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.162680  2532 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
22:21:55.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.162736  2532 flags.cc:425] Enabled unsafe flag: --never_fsync=true
22:21:55.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.166877  2532 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
22:21:55.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.167034  2532 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.2.15.130
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.171936  2532 tablet_server_runner.cc:78] Tablet server non-default flags:
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/data
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/wal
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.130:0
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/data/info.pb
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.130
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.2532
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
22:21:55.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.15.130
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/logs
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 21:46:50 UTC on ccycloud.quasar-irklax.root.comops.site
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492326
22:21:55.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.173326  2532 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
22:21:55.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.174901  2532 file_cache.cc:493] Constructed file cache file cache with capacity 419430
22:21:55.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.184894  2537 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
22:21:55.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.184922  2540 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
22:21:55.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.185086  2532 server_base.cc:1034] running on GCE node
22:21:55.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.184894  2538 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
22:21:55.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.185818  2532 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
22:21:55.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.186435  2532 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
22:21:55.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.187566  2532 hybrid_clock.cc:648] HybridClock initialized: now 1783462915187531 us; error 48 us; skew 500 ppm
22:21:55.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.189381  2532 webserver.cc:460] Webserver started at http://127.2.15.130:42319/ using document root <none> and password file <none>
22:21:55.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.189904  2532 fs_manager.cc:359] Metadata directory not provided
22:21:55.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.189963  2532 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
22:21:55.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.190124  2532 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
22:21:55.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.192087  2532 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/data/instance:
22:21:55.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b8d02129f8c3446ab970f37e475574fe"
22:21:55.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:55 on dist-test-slave-x101"
22:21:55.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.192600  2532 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/wal/instance:
22:21:55.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b8d02129f8c3446ab970f37e475574fe"
22:21:55.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:55 on dist-test-slave-x101"
22:21:55.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.196262  2532 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.003s	sys 0.001s
22:21:55.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.198710  2546 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.200062  2532 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.001s
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.200157  2532 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/data,/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/wal
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b8d02129f8c3446ab970f37e475574fe"
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:55 on dist-test-slave-x101"
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.200253  2532 fs_report.cc:383] FS layout report
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/wal
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/wal
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/data/data
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
22:21:55.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
22:21:55.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
22:21:55.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
22:21:55.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.215740  2532 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
22:21:55.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.216385  2532 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
22:21:55.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.216529  2532 kserver.cc:163] Server-wide thread pool size limit: 3276
22:21:55.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.217059  2532 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
22:21:55.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.218050  2532 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
22:21:55.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.218097  2532 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
22:21:55.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.218137  2532 ts_tablet_manager.cc:610] Registered 0 tablets
22:21:55.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.218153  2532 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
22:21:55.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.228295  2532 rpc_server.cc:307] RPC server started. Bound to: 127.2.15.130:40715
22:21:55.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.228318  2659 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.15.130:40715 every 8 connection(s)
22:21:55.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.229265  2532 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/data/info.pb
22:21:55.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.233547  2110 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskz_BPic/build/debug/bin/kudu as pid 2532
22:21:55.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.233671  2110 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-1/wal/instance
22:21:55.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.237242  2110 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:55.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskz_BPic/build/debug/bin/kudu
22:21:55.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/wal
22:21:55.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/data
22:21:55.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
22:21:55.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
22:21:55.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
22:21:55.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:55.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:55.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/logs
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/data/info.pb
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.131:0
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.15.131
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.131
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:55.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
22:21:55.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.242326  2661 heartbeater.cc:347] Connected to a master server at 127.2.15.190:44541
22:21:55.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.242460  2662 heartbeater.cc:347] Connected to a master server at 127.2.15.189:33075
22:21:55.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.242551  2662 heartbeater.cc:464] Registering TS with master...
22:21:55.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.242553  2661 heartbeater.cc:464] Registering TS with master...
22:21:55.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.242928  2660 heartbeater.cc:347] Connected to a master server at 127.2.15.188:35115
22:21:55.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.243016  2660 heartbeater.cc:464] Registering TS with master...
22:21:55.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.243264  2661 heartbeater.cc:511] Master 127.2.15.190:44541 requested a full tablet report, sending...
22:21:55.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.243264  2660 heartbeater.cc:511] Master 127.2.15.188:35115 requested a full tablet report, sending...
22:21:55.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.243264  2662 heartbeater.cc:511] Master 127.2.15.189:33075 requested a full tablet report, sending...
22:21:55.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.244382  2223 ts_manager.cc:194] Registered new tserver with Master: b8d02129f8c3446ab970f37e475574fe (127.2.15.130:40715)
22:21:55.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.244382  2152 ts_manager.cc:194] Registered new tserver with Master: b8d02129f8c3446ab970f37e475574fe (127.2.15.130:40715)
22:21:55.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.244379  2296 ts_manager.cc:194] Registered new tserver with Master: b8d02129f8c3446ab970f37e475574fe (127.2.15.130:40715)
22:21:55.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.245245  2296 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.2.15.130:34835
22:21:55.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.325682  2366 catalog_manager.cc:1259] Loaded cluster ID: 1afc5abcf95e4ff281278893503e4900
22:21:55.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.325765  2366 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c: loading cluster ID for follower catalog manager: success
22:21:55.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.328208  2366 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c: acquiring CA information for follower catalog manager: success
22:21:55.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.329391  2366 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 6f68e4ac85cb4b8084598ff1fca7204c: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
22:21:55.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.354436  2380 catalog_manager.cc:1259] Loaded cluster ID: 1afc5abcf95e4ff281278893503e4900
22:21:55.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.354519  2380 catalog_manager.cc:1552] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade: loading cluster ID for follower catalog manager: success
22:21:55.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.356315  2380 catalog_manager.cc:1574] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade: acquiring CA information for follower catalog manager: success
22:21:55.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.357514  2380 catalog_manager.cc:1602] T 00000000000000000000000000000000 P b0c2cf18bfc246929917a73fc7351ade: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
22:21:55.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.362483  2667 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
22:21:55.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.362769  2667 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
22:21:55.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.362823  2667 flags.cc:425] Enabled unsafe flag: --never_fsync=true
22:21:55.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.367061  2667 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
22:21:55.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.367218  2667 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.2.15.131
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.372306  2667 tablet_server_runner.cc:78] Tablet server non-default flags:
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.15.148:36103
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/data
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/wal
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.15.131:0
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
22:21:55.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/data/info.pb
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.15.131
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.15.190:44541,127.2.15.189:33075,127.2.15.188:35115
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.2667
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.15.131
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/logs
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 07 Jul 2026 21:46:50 UTC on ccycloud.quasar-irklax.root.comops.site
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492326
22:21:55.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.373761  2667 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
22:21:55.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.375288  2667 file_cache.cc:493] Constructed file cache file cache with capacity 419430
22:21:55.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.385713  2675 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
22:21:55.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.385713  2673 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
22:21:55.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 22:21:55.385715  2672 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
22:21:55.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.385932  2667 server_base.cc:1034] running on GCE node
22:21:55.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.386323  2667 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
22:21:55.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.387035  2667 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
22:21:55.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.388211  2667 hybrid_clock.cc:648] HybridClock initialized: now 1783462915388191 us; error 38 us; skew 500 ppm
22:21:55.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.389969  2667 webserver.cc:460] Webserver started at http://127.2.15.131:39803/ using document root <none> and password file <none>
22:21:55.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.390533  2667 fs_manager.cc:359] Metadata directory not provided
22:21:55.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.390609  2667 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
22:21:55.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.390779  2667 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
22:21:55.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.392663  2667 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/data/instance:
22:21:55.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "29c7e44ec92d4fa7961f2df5b7cd6a0a"
22:21:55.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:55 on dist-test-slave-x101"
22:21:55.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.393182  2667 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/wal/instance:
22:21:55.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "29c7e44ec92d4fa7961f2df5b7cd6a0a"
22:21:55.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:55 on dist-test-slave-x101"
22:21:55.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.396797  2667 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.004s	sys 0.000s
22:21:55.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.399103  2681 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.400467  2667 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.400568  2667 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/data,/tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/wal
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "29c7e44ec92d4fa7961f2df5b7cd6a0a"
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 22:21:55 on dist-test-slave-x101"
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.400655  2667 fs_report.cc:383] FS layout report
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/wal
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/wal
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/data/data
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
22:21:55.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
22:21:55.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
22:21:55.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
22:21:55.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
22:21:55.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.415324  2667 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
22:21:55.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.416066  2667 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
22:21:55.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.416216  2667 kserver.cc:163] Server-wide thread pool size limit: 3276
22:21:55.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.416724  2667 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
22:21:55.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.417629  2667 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
22:21:55.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.417675  2667 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
22:21:55.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.417714  2667 ts_tablet_manager.cc:610] Registered 0 tablets
22:21:55.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.417729  2667 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
22:21:55.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.427273  2667 rpc_server.cc:307] RPC server started. Bound to: 127.2.15.131:42811
22:21:55.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.427299  2794 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.15.131:42811 every 8 connection(s)
22:21:55.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.428246  2667 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/data/info.pb
22:21:55.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.436335  2110 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskz_BPic/build/debug/bin/kudu as pid 2667
22:21:55.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.436458  2110 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskz_BPic/test-tmp/mini-kudu-cluster907037909205497572/ts-2/wal/instance
22:21:55.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.440423  2796 heartbeater.cc:347] Connected to a master server at 127.2.15.190:44541
22:21:55.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.440495  2795 heartbeater.cc:347] Connected to a master server at 127.2.15.188:35115
22:21:55.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.440690  2795 heartbeater.cc:464] Registering TS with master...
22:21:55.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.440690  2796 heartbeater.cc:464] Registering TS with master...
22:21:55.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.440713  2797 heartbeater.cc:347] Connected to a master server at 127.2.15.189:33075
22:21:55.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.441272  2795 heartbeater.cc:511] Master 127.2.15.188:35115 requested a full tablet report, sending...
22:21:55.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.441272  2796 heartbeater.cc:511] Master 127.2.15.190:44541 requested a full tablet report, sending...
22:21:55.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.441327  2797 heartbeater.cc:464] Registering TS with master...
22:21:55.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.441520  2797 heartbeater.cc:511] Master 127.2.15.189:33075 requested a full tablet report, sending...
22:21:55.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.442428  2224 ts_manager.cc:194] Registered new tserver with Master: 29c7e44ec92d4fa7961f2df5b7cd6a0a (127.2.15.131:42811)
22:21:55.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.442574  2152 ts_manager.cc:194] Registered new tserver with Master: 29c7e44ec92d4fa7961f2df5b7cd6a0a (127.2.15.131:42811)
22:21:55.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.442828  2295 ts_manager.cc:194] Registered new tserver with Master: 29c7e44ec92d4fa7961f2df5b7cd6a0a (127.2.15.131:42811)
22:21:55.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.443385  2295 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.2.15.131:35663
22:21:55.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:55.456430  2110 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
22:21:55.457 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
22:21:55.458 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

22:21:55.466 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.2.15.190"
      port: 44541
    }
    bound_http_address {
      host: "127.2.15.190"
      port: 36157
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.2.15.189"
      port: 33075
    }
    bound_http_address {
      host: "127.2.15.189"
      port: 43125
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.2.15.188"
      port: 35115
    }
    bound_http_address {
      host: "127.2.15.188"
      port: 39479
    }
  }
}

22:21:55.472 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

22:21:55.475 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.2.15.129"
      port: 35601
    }
    bound_http_address {
      host: "127.2.15.129"
      port: 33471
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.2.15.130"
      port: 40715
    }
    bound_http_address {
      host: "127.2.15.130"
      port: 42319
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.2.15.131"
      port: 42811
    }
    bound_http_address {
      host: "127.2.15.131"
      port: 39803
    }
  }
}

22:21:55.477 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
22:21:55.485 [DEBUG - main] (InternalLoggerFactory.java:63) Using SLF4J as the default logging framework
22:21:55.489 [DEBUG - main] (ResourceLeakDetector.java:129) -Dorg.apache.kudu.shaded.io.netty.leakDetection.level: simple
22:21:55.490 [DEBUG - main] (ResourceLeakDetector.java:130) -Dorg.apache.kudu.shaded.io.netty.leakDetection.targetRecords: 4
22:21:55.495 [DEBUG - main] (ResourceLeakDetectorFactory.java:196) Loaded default ResourceLeakDetector: org.apache.kudu.shaded.io.netty.util.ResourceLeakDetector@68044f4
22:21:55.515 [DEBUG - main] (PlatformDependent0.java:497) -Dio.netty.noUnsafe: false
22:21:55.515 [DEBUG - main] (PlatformDependent0.java:1001) Java version: 8
22:21:55.516 [DEBUG - main] (PlatformDependent0.java:137) sun.misc.Unsafe.theUnsafe: available
22:21:55.516 [DEBUG - main] (PlatformDependent0.java:161) sun.misc.Unsafe.copyMemory: available
22:21:55.517 [DEBUG - main] (PlatformDependent0.java:193) sun.misc.Unsafe.storeFence: available
22:21:55.517 [DEBUG - main] (PlatformDependent0.java:236) java.nio.Buffer.address: available
22:21:55.517 [DEBUG - main] (PlatformDependent0.java:308) direct buffer constructor: available
22:21:55.518 [DEBUG - main] (PlatformDependent0.java:386) java.nio.Bits.unaligned: available, true
22:21:55.518 [DEBUG - main] (PlatformDependent0.java:460) jdk.internal.misc.Unsafe.allocateUninitializedArray(int): unavailable prior to Java9
22:21:55.518 [DEBUG - main] (PlatformDependent0.java:483) java.nio.DirectByteBuffer.<init>(long, {int,long}): available
22:21:55.518 [DEBUG - main] (PlatformDependent.java:1159) sun.misc.Unsafe: available
22:21:55.519 [DEBUG - main] (PlatformDependent.java:1289) -Dio.netty.tmpdir: /tmp (java.io.tmpdir)
22:21:55.519 [DEBUG - main] (PlatformDependent.java:1368) -Dio.netty.bitMode: 64 (sun.arch.data.model)
22:21:55.520 [DEBUG - main] (PlatformDependent.java:178) -Dio.netty.maxDirectMemory: 3799121920 bytes
22:21:55.520 [DEBUG - main] (PlatformDependent.java:185) -Dio.netty.uninitializedArrayAllocationThreshold: -1
22:21:55.521 [DEBUG - main] (CleanerJava6.java:92) java.nio.ByteBuffer.cleaner(): available
22:21:55.521 [DEBUG - main] (PlatformDependent.java:205) -Dio.netty.noPreferDirect: false
22:21:55.529 [DEBUG - main] (PlatformDependent.java:1010) org.jctools-core.MpscChunkedArrayQueue: available
22:21:55.562 [DEBUG - main] (MultithreadEventLoopGroup.java:44) -Dio.netty.eventLoopThreads: 2
22:21:55.571 [DEBUG - main] (GlobalEventExecutor.java:53) -Dio.netty.globalEventExecutor.quietPeriodSeconds: 1
22:21:55.577 [DEBUG - main] (InternalThreadLocalMap.java:100) -Dio.netty.threadLocalMap.stringBuilder.initialSize: 1024
22:21:55.577 [DEBUG - main] (InternalThreadLocalMap.java:101) -Dio.netty.threadLocalMap.stringBuilder.maxSize: 4096
22:21:55.584 [DEBUG - main] (NioEventLoop.java:110) -Dio.netty.noKeySetOptimization: false
22:21:55.584 [DEBUG - main] (NioEventLoop.java:111) -Dio.netty.selectorAutoRebuildThreshold: 512
22:21:55.616 [DEBUG - main] (PooledByteBufAllocator.java:157) -Dio.netty.allocator.numHeapArenas: 2
22:21:55.616 [DEBUG - main] (PooledByteBufAllocator.java:158) -Dio.netty.allocator.numDirectArenas: 2
22:21:55.616 [DEBUG - main] (PooledByteBufAllocator.java:160) -Dio.netty.allocator.pageSize: 8192
22:21:55.616 [DEBUG - main] (PooledByteBufAllocator.java:165) -Dio.netty.allocator.maxOrder: 9
22:21:55.616 [DEBUG - main] (PooledByteBufAllocator.java:169) -Dio.netty.allocator.chunkSize: 4194304
22:21:55.616 [DEBUG - main] (PooledByteBufAllocator.java:170) -Dio.netty.allocator.smallCacheSize: 256
22:21:55.616 [DEBUG - main] (PooledByteBufAllocator.java:171) -Dio.netty.allocator.normalCacheSize: 64
22:21:55.617 [DEBUG - main] (PooledByteBufAllocator.java:172) -Dio.netty.allocator.maxCachedBufferCapacity: 32768
22:21:55.617 [DEBUG - main] (PooledByteBufAllocator.java:173) -Dio.netty.allocator.cacheTrimInterval: 8192
22:21:55.617 [DEBUG - main] (PooledByteBufAllocator.java:174) -Dio.netty.allocator.cacheTrimIntervalMillis: 0
22:21:55.617 [DEBUG - main] (PooledByteBufAllocator.java:175) -Dio.netty.allocator.useCacheForAllThreads: false
22:21:55.617 [DEBUG - main] (PooledByteBufAllocator.java:176) -Dio.netty.allocator.maxCachedByteBuffersPerChunk: 1023
22:21:55.648 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
22:21:55.767 [INFO - main] (Logging.scala:57) Running Spark version 3.1.2
22:21:55.983 [WARN - main] (NativeCodeLoader.java:60) Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
22:21:56.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:56.039978  2522 heartbeater.cc:503] Master 127.2.15.188:35115 was elected leader, sending a full tablet report...
22:21:56.103 [INFO - main] (Logging.scala:57) ==============================================================
22:21:56.104 [INFO - main] (Logging.scala:57) No custom resources configured for spark.driver.
22:21:56.104 [INFO - main] (Logging.scala:57) ==============================================================
22:21:56.105 [INFO - main] (Logging.scala:57) Submitted application: test
22:21:56.137 [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)
22:21:56.156 [INFO - main] (Logging.scala:57) Limiting resource is cpu
22:21:56.157 [INFO - main] (Logging.scala:57) Added ResourceProfile id: 0
22:21:56.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:56.247673  2660 heartbeater.cc:503] Master 127.2.15.188:35115 was elected leader, sending a full tablet report...
22:21:56.279 [INFO - main] (Logging.scala:57) Changing view acls to: slave
22:21:56.280 [INFO - main] (Logging.scala:57) Changing modify acls to: slave
22:21:56.280 [INFO - main] (Logging.scala:57) Changing view acls groups to: 
22:21:56.281 [INFO - main] (Logging.scala:57) Changing modify acls groups to: 
22:21:56.282 [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()
22:21:56.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:56.445175  2795 heartbeater.cc:503] Master 127.2.15.188:35115 was elected leader, sending a full tablet report...
22:21:56.620 [INFO - main] (Logging.scala:57) Successfully started service 'sparkDriver' on port 36817.
22:21:56.653 [INFO - main] (Logging.scala:57) Registering MapOutputTracker
22:21:56.692 [INFO - main] (Logging.scala:57) Registering BlockManagerMaster
22:21:56.717 [INFO - main] (Logging.scala:57) Using org.apache.spark.storage.DefaultTopologyMapper for getting topology information
22:21:56.718 [INFO - main] (Logging.scala:57) BlockManagerMasterEndpoint up
22:21:56.723 [INFO - main] (Logging.scala:57) Registering BlockManagerMasterHeartbeat
22:21:56.740 [INFO - main] (Logging.scala:57) Created local directory at /tmp/blockmgr-eb149486-a102-4e87-93d8-d3168f56a5c7
22:21:56.795 [INFO - main] (Logging.scala:57) MemoryStore started with capacity 1993.9 MiB
22:21:56.818 [INFO - main] (Logging.scala:57) Registering OutputCommitCoordinator
22:21:57.000 [INFO - main] (Logging.scala:57) Starting executor ID driver on host dist-test-slave-x101.c.gcp-upstream.internal
22:21:57.041 [INFO - main] (Logging.scala:57) Successfully started service 'org.apache.spark.network.netty.NettyBlockTransferService' on port 42565.
22:21:57.041 [INFO - main] (NettyBlockTransferService.scala:81) Server created on dist-test-slave-x101.c.gcp-upstream.internal:42565
22:21:57.044 [INFO - main] (Logging.scala:57) Using org.apache.spark.storage.RandomBlockReplicationPolicy for block replication policy
22:21:57.055 [INFO - main] (Logging.scala:57) Registering BlockManager BlockManagerId(driver, dist-test-slave-x101.c.gcp-upstream.internal, 42565, None)
22:21:57.060 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Registering block manager dist-test-slave-x101.c.gcp-upstream.internal:42565 with 1993.9 MiB RAM, BlockManagerId(driver, dist-test-slave-x101.c.gcp-upstream.internal, 42565, None)
22:21:57.064 [INFO - main] (Logging.scala:57) Registered BlockManager BlockManagerId(driver, dist-test-slave-x101.c.gcp-upstream.internal, 42565, None)
22:21:57.066 [INFO - main] (Logging.scala:57) Initialized BlockManager: BlockManagerId(driver, dist-test-slave-x101.c.gcp-upstream.internal, 42565, None)
22:21:57.302 [INFO - main] (Log.java:169) Logging initialized @5600ms to org.sparkproject.jetty.util.log.Slf4jLog
22:21:57.545 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
22:21:57.595 [DEBUG - main] (Connection.java:748) [peer master-127.2.15.188:35115(127.2.15.188:35115)] connecting to peer
22:21:57.601 [DEBUG - main] (DefaultChannelId.java:79) -Dio.netty.processId: 2097 (auto-detected)
22:21:57.603 [DEBUG - main] (NetUtil.java:148) -Djava.net.preferIPv4Stack: true
22:21:57.604 [DEBUG - main] (NetUtil.java:149) -Djava.net.preferIPv6Addresses: false
22:21:57.606 [DEBUG - main] (NetUtilInitializations.java:145) Loopback interface: lo (lo, 127.0.0.1)
22:21:57.607 [DEBUG - main] (NetUtil.java:188) /proc/sys/net/core/somaxconn: 4096
22:21:57.608 [DEBUG - main] (DefaultChannelId.java:101) -Dio.netty.machineId: 02:42:0d:ff:fe:ce:cd:b7 (auto-detected)
22:21:57.631 [DEBUG - main] (ByteBufUtil.java:88) -Dio.netty.allocator.type: pooled
22:21:57.631 [DEBUG - main] (ByteBufUtil.java:97) -Dio.netty.threadLocalDirectBufferSize: 0
22:21:57.631 [DEBUG - main] (ByteBufUtil.java:100) -Dio.netty.maxThreadLocalCharBufferSize: 16384
22:21:57.641 [DEBUG - main] (Connection.java:748) [peer master-127.2.15.190:44541(127.2.15.190:44541)] connecting to peer
22:21:57.643 [DEBUG - main] (Connection.java:748) [peer master-127.2.15.189:33075(127.2.15.189:33075)] connecting to peer
22:21:57.667 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.2.15.188:35115(127.2.15.188:35115)] Successfully connected to peer
22:21:57.667 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.2.15.190:44541(127.2.15.190:44541)] Successfully connected to peer
22:21:57.679 [DEBUG - kudu-nio-0] (AbstractByteBuf.java:63) -Dorg.apache.kudu.shaded.io.netty.buffer.checkAccessible: true
22:21:57.679 [DEBUG - kudu-nio-0] (AbstractByteBuf.java:64) -Dorg.apache.kudu.shaded.io.netty.buffer.checkBounds: true
22:21:57.680 [DEBUG - kudu-nio-0] (ResourceLeakDetectorFactory.java:196) Loaded default ResourceLeakDetector: org.apache.kudu.shaded.io.netty.util.ResourceLeakDetector@654a8332
22:21:57.685 [DEBUG - kudu-nio-1] (Recycler.java:96) -Dio.netty.recycler.maxCapacityPerThread: 4096
22:21:57.685 [DEBUG - kudu-nio-1] (Recycler.java:97) -Dio.netty.recycler.ratio: 8
22:21:57.685 [DEBUG - kudu-nio-1] (Recycler.java:98) -Dio.netty.recycler.chunkSize: 32
22:21:57.685 [DEBUG - kudu-nio-1] (Recycler.java:99) -Dio.netty.recycler.blocking: false
22:21:57.685 [DEBUG - kudu-nio-1] (Recycler.java:100) -Dio.netty.recycler.batchFastThreadLocalOnly: true
22:21:57.728 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.2.15.189:33075(127.2.15.189:33075)] Successfully connected to peer
22:21:57.748 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.2.15.190
22:21:57.748 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.2.15.188
22:21:57.932 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.2.15.189
22:21:57.934 [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
22:21:57.940 [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
22:21:57.947 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x2385bf4c, L:/127.0.0.1:51442 - R:/127.2.15.190:44541] using SASL/PLAIN
22:21:57.960 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xd3dd7fea, L:/127.0.0.1:36588 - R:/127.2.15.188:35115] using SASL/PLAIN
22:21:57.963 [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
22:21:58.002 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
22:21:58.011 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x09fff8ee, L:/127.0.0.1:57766 - R:/127.2.15.189:33075] using SASL/PLAIN
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.068739  2295 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:36588:
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "test"
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c1_i"
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c2_s"
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
22:21:58.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c3_double"
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DOUBLE
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c4_long"
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT64
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c5_bool"
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c6_short"
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT16
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c7_float"
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: FLOAT
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c8_binary"
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BINARY
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c9_unixtime_micros"
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: UNIXTIME_MICROS
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c10_byte"
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT8
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c11_decimal32"
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL32
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 9
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c12_decimal64"
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL64
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 18
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c13_decimal128"
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL128
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
22:21:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 38
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c14_varchar"
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: VARCHAR
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       length: 65535
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c15_date"
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DATE
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) split_rows_range_bounds {
22:21:58.074 [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"
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
22:21:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
22:21:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
22:21:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
22:21:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
22:21:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) owner: "testuser"
22:21:58.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.095872  2594 tablet_service.cc:1467] Processing CreateTablet for tablet c001ff3175fc474fa9e40f3a895560b8 (DEFAULT_TABLE table=test [id=50f87da8ab3e47ac92abd9a0faa28a5d]), partition=RANGE (key) PARTITION 50 <= VALUES
22:21:58.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.095870  2456 tablet_service.cc:1467] Processing CreateTablet for tablet cb9533ba87e740d18c263ac76673f4dd (DEFAULT_TABLE table=test [id=50f87da8ab3e47ac92abd9a0faa28a5d]), partition=RANGE (key) PARTITION VALUES < 50
22:21:58.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.097375  2456 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet cb9533ba87e740d18c263ac76673f4dd. 1 dirs total, 0 dirs full, 0 dirs failed
22:21:58.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.099586  2594 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet c001ff3175fc474fa9e40f3a895560b8. 1 dirs total, 0 dirs full, 0 dirs failed
22:21:58.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.107300  2855 tablet_bootstrap.cc:492] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e: Bootstrap starting.
22:21:58.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.110061  2855 tablet_bootstrap.cc:654] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e: Neither blocks nor log segments found. Creating new log.
22:21:58.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.111461  2855 log.cc:824] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e: Log is configured to *not* fsync() on all Append() calls
22:21:58.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.111877  2856 tablet_bootstrap.cc:492] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe: Bootstrap starting.
22:21:58.112 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 50f87da8ab3e47ac92abd9a0faa28a5d
22:21:58.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.113756  2855 tablet_bootstrap.cc:492] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e: No bootstrap required, opened a new log
22:21:58.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.113960  2855 ts_tablet_manager.cc:1397] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e: Time spent bootstrapping tablet: real 0.007s	user 0.006s	sys 0.000s
22:21:58.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.114279  2856 tablet_bootstrap.cc:654] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe: Neither blocks nor log segments found. Creating new log.
22:21:58.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.115538  2856 log.cc:824] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe: Log is configured to *not* fsync() on all Append() calls
22:21:58.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.117363  2856 tablet_bootstrap.cc:492] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe: No bootstrap required, opened a new log
22:21:58.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.117535  2856 ts_tablet_manager.cc:1397] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe: Time spent bootstrapping tablet: real 0.006s	user 0.004s	sys 0.000s
22:21:58.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.117352  2855 raft_consensus.cc:348] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "d308134a0fa24d0182be18f09014218e" member_type: VOTER last_known_addr { host: "127.2.15.129" port: 35601 } }
22:21:58.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.117616  2855 raft_consensus.cc:374] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
22:21:58.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.117686  2855 raft_consensus.cc:729] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: d308134a0fa24d0182be18f09014218e, State: Initialized, Role: FOLLOWER
22:21:58.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.118124  2855 consensus_queue.cc:260] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [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: "d308134a0fa24d0182be18f09014218e" member_type: VOTER last_known_addr { host: "127.2.15.129" port: 35601 } }
22:21:58.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.118285  2855 raft_consensus.cc:388] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
22:21:58.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.118355  2855 raft_consensus.cc:482] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
22:21:58.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.118451  2855 raft_consensus.cc:3037] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [term 0 FOLLOWER]: Advancing to term 1
22:21:58.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.119417  2855 raft_consensus.cc:504] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "d308134a0fa24d0182be18f09014218e" member_type: VOTER last_known_addr { host: "127.2.15.129" port: 35601 } }
22:21:58.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.120056  2855 leader_election.cc:302] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [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: d308134a0fa24d0182be18f09014218e; no voters: 
22:21:58.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.120435  2855 leader_election.cc:288] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [CANDIDATE]: Term 1 election: Requested vote from peers 
22:21:58.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.121460  2855 ts_tablet_manager.cc:1428] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e: Time spent starting tablet: real 0.007s	user 0.002s	sys 0.004s
22:21:58.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.127656  2859 raft_consensus.cc:2781] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [term 1 FOLLOWER]: Leader election won for term 1
22:21:58.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.128114  2859 raft_consensus.cc:686] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [term 1 LEADER]: Becoming Leader. State: Replica: d308134a0fa24d0182be18f09014218e, State: Running, Role: LEADER
22:21:58.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.128599  2859 consensus_queue.cc:237] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e [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: "d308134a0fa24d0182be18f09014218e" member_type: VOTER last_known_addr { host: "127.2.15.129" port: 35601 } }
22:21:58.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.128882  2856 raft_consensus.cc:348] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "b8d02129f8c3446ab970f37e475574fe" member_type: VOTER last_known_addr { host: "127.2.15.130" port: 40715 } }
22:21:58.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.129153  2856 raft_consensus.cc:374] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
22:21:58.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.129195  2856 raft_consensus.cc:729] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b8d02129f8c3446ab970f37e475574fe, State: Initialized, Role: FOLLOWER
22:21:58.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.129714  2856 consensus_queue.cc:260] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [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: "b8d02129f8c3446ab970f37e475574fe" member_type: VOTER last_known_addr { host: "127.2.15.130" port: 40715 } }
22:21:58.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.130002  2856 raft_consensus.cc:388] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
22:21:58.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.130169  2856 raft_consensus.cc:482] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
22:21:58.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.130398  2856 raft_consensus.cc:3037] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [term 0 FOLLOWER]: Advancing to term 1
22:21:58.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.132485  2295 catalog_manager.cc:5495] T cb9533ba87e740d18c263ac76673f4dd P d308134a0fa24d0182be18f09014218e reported cstate change: term changed from 0 to 1, leader changed from <none> to d308134a0fa24d0182be18f09014218e (127.2.15.129). New cstate: current_term: 1 leader_uuid: "d308134a0fa24d0182be18f09014218e" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "d308134a0fa24d0182be18f09014218e" member_type: VOTER last_known_addr { host: "127.2.15.129" port: 35601 } health_report { overall_health: HEALTHY } } }
22:21:58.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.133805  2856 raft_consensus.cc:504] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "b8d02129f8c3446ab970f37e475574fe" member_type: VOTER last_known_addr { host: "127.2.15.130" port: 40715 } }
22:21:58.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.134150  2856 leader_election.cc:302] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [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: b8d02129f8c3446ab970f37e475574fe; no voters: 
22:21:58.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.134481  2856 leader_election.cc:288] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [CANDIDATE]: Term 1 election: Requested vote from peers 
22:21:58.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.134600  2862 raft_consensus.cc:2781] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [term 1 FOLLOWER]: Leader election won for term 1
22:21:58.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.134799  2862 raft_consensus.cc:686] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [term 1 LEADER]: Becoming Leader. State: Replica: b8d02129f8c3446ab970f37e475574fe, State: Running, Role: LEADER
22:21:58.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.135103  2862 consensus_queue.cc:237] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe [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: "b8d02129f8c3446ab970f37e475574fe" member_type: VOTER last_known_addr { host: "127.2.15.130" port: 40715 } }
22:21:58.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.135593  2856 ts_tablet_manager.cc:1428] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe: Time spent starting tablet: real 0.018s	user 0.005s	sys 0.004s
22:21:58.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.138234  2296 catalog_manager.cc:5495] T c001ff3175fc474fa9e40f3a895560b8 P b8d02129f8c3446ab970f37e475574fe reported cstate change: term changed from 0 to 1, leader changed from <none> to b8d02129f8c3446ab970f37e475574fe (127.2.15.130). New cstate: current_term: 1 leader_uuid: "b8d02129f8c3446ab970f37e475574fe" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "b8d02129f8c3446ab970f37e475574fe" member_type: VOTER last_known_addr { host: "127.2.15.130" port: 40715 } health_report { overall_health: HEALTHY } } }
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.164772  2296 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:36588:
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "simple-test"
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "val"
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
22:21:58.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
22:21:58.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
22:21:58.177 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 42ddc4701aaf40c0ad9494670e3f2cb2
22:21:58.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.181882  2729 tablet_service.cc:1467] Processing CreateTablet for tablet 390201e4dec24dc9b3918cf75bbe2675 (DEFAULT_TABLE table=simple-test [id=42ddc4701aaf40c0ad9494670e3f2cb2]), partition=RANGE (key) PARTITION UNBOUNDED
22:21:58.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.183050  2729 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 390201e4dec24dc9b3918cf75bbe2675. 1 dirs total, 0 dirs full, 0 dirs failed
22:21:58.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.189814  2869 tablet_bootstrap.cc:492] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a: Bootstrap starting.
22:21:58.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.192008  2869 tablet_bootstrap.cc:654] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a: Neither blocks nor log segments found. Creating new log.
22:21:58.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.192836  2869 log.cc:824] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a: Log is configured to *not* fsync() on all Append() calls
22:21:58.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.194577  2869 tablet_bootstrap.cc:492] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a: No bootstrap required, opened a new log
22:21:58.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.194820  2869 ts_tablet_manager.cc:1397] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a: Time spent bootstrapping tablet: real 0.005s	user 0.004s	sys 0.000s
22:21:58.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.198177  2869 raft_consensus.cc:348] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "29c7e44ec92d4fa7961f2df5b7cd6a0a" member_type: VOTER last_known_addr { host: "127.2.15.131" port: 42811 } }
22:21:58.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.198426  2869 raft_consensus.cc:374] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
22:21:58.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.198482  2869 raft_consensus.cc:729] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 29c7e44ec92d4fa7961f2df5b7cd6a0a, State: Initialized, Role: FOLLOWER
22:21:58.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.198951  2869 consensus_queue.cc:260] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [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: "29c7e44ec92d4fa7961f2df5b7cd6a0a" member_type: VOTER last_known_addr { host: "127.2.15.131" port: 42811 } }
22:21:58.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.199121  2869 raft_consensus.cc:388] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
22:21:58.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.199189  2869 raft_consensus.cc:482] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
22:21:58.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.199290  2869 raft_consensus.cc:3037] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [term 0 FOLLOWER]: Advancing to term 1
22:21:58.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.200366  2869 raft_consensus.cc:504] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "29c7e44ec92d4fa7961f2df5b7cd6a0a" member_type: VOTER last_known_addr { host: "127.2.15.131" port: 42811 } }
22:21:58.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.200923  2869 leader_election.cc:302] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [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: 29c7e44ec92d4fa7961f2df5b7cd6a0a; no voters: 
22:21:58.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.201375  2869 leader_election.cc:288] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [CANDIDATE]: Term 1 election: Requested vote from peers 
22:21:58.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.202320  2871 raft_consensus.cc:2781] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [term 1 FOLLOWER]: Leader election won for term 1
22:21:58.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.202612  2869 ts_tablet_manager.cc:1428] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a: Time spent starting tablet: real 0.008s	user 0.005s	sys 0.004s
22:21:58.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.202620  2871 raft_consensus.cc:686] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [term 1 LEADER]: Becoming Leader. State: Replica: 29c7e44ec92d4fa7961f2df5b7cd6a0a, State: Running, Role: LEADER
22:21:58.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.202996  2871 consensus_queue.cc:237] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a [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: "29c7e44ec92d4fa7961f2df5b7cd6a0a" member_type: VOTER last_known_addr { host: "127.2.15.131" port: 42811 } }
22:21:58.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:21:58.206821  2296 catalog_manager.cc:5495] T 390201e4dec24dc9b3918cf75bbe2675 P 29c7e44ec92d4fa7961f2df5b7cd6a0a reported cstate change: term changed from 0 to 1, leader changed from <none> to 29c7e44ec92d4fa7961f2df5b7cd6a0a (127.2.15.131). New cstate: current_term: 1 leader_uuid: "29c7e44ec92d4fa7961f2df5b7cd6a0a" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "29c7e44ec92d4fa7961f2df5b7cd6a0a" member_type: VOTER last_known_addr { host: "127.2.15.131" port: 42811 } health_report { overall_health: HEALTHY } } }
22:21:59.852 [INFO - main] (Logging.scala:57) Setting hive.metastore.warehouse.dir ('null') to the value of spark.sql.warehouse.dir ('file:/tmp/dist-test-taskz_BPic/java/build/dist-test/spark-warehouse').
22:21:59.852 [INFO - main] (Logging.scala:57) Warehouse path is 'file:/tmp/dist-test-taskz_BPic/java/build/dist-test/spark-warehouse'.
22:22:01.255 [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.
22:22:01.368 [INFO - main] (Logging.scala:57) Checkpoint root /tmp/spark_kudu7280221073061568760 resolved to file:/tmp/spark_kudu7280221073061568760.
22:22:01.435 [INFO - main] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu7280221073061568760/metadata using temp file file:/tmp/spark_kudu7280221073061568760/.metadata.efc361d1-04f6-48d2-b440-9701888e11b4.tmp
22:22:01.549 [INFO - main] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu7280221073061568760/.metadata.efc361d1-04f6-48d2-b440-9701888e11b4.tmp to file:/tmp/spark_kudu7280221073061568760/metadata
22:22:01.588 [INFO - main] (Logging.scala:57) Starting [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]. Use file:/tmp/spark_kudu7280221073061568760 to store the query checkpoint.
22:22:01.609 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Reading table [org.apache.spark.sql.execution.streaming.MemoryStreamTable@44b00106] from DataSourceV2 named 'memory' [org.apache.spark.sql.execution.streaming.MemoryStreamTableProvider$@6fddbfa1]
22:22:01.621 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Starting new streaming query.
22:22:01.625 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Stream started from {}
22:22:01.684 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Streaming query made progress: {
  "id" : "64e01798-f5f9-467e-9803-1183c34a8e96",
  "runId" : "de2721d9-4b0a-47dd-9da1-c8e549ea31a8",
  "name" : null,
  "timestamp" : "2026-07-07T22:22:01.618Z",
  "batchId" : 0,
  "numInputRows" : 0,
  "inputRowsPerSecond" : 0.0,
  "processedRowsPerSecond" : 0.0,
  "durationMs" : {
    "latestOffset" : 0,
    "triggerExecution" : 14
  },
  "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@8a2fc71",
    "numOutputRows" : -1
  }
}
22:22:01.970 [INFO - main] (Logging.scala:57) Code generated in 232.010529 ms
22:22:01.995 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu7280221073061568760/offsets/0 using temp file file:/tmp/spark_kudu7280221073061568760/offsets/.0.1dd790e8-d6dc-45e5-a38c-a09434d8d4b0.tmp
22:22:02.036 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu7280221073061568760/offsets/.0.1dd790e8-d6dc-45e5-a38c-a09434d8d4b0.tmp to file:/tmp/spark_kudu7280221073061568760/offsets/0
22:22:02.037 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Committed offsets for batch 0. Metadata OffsetSeqMetadata(0,1783462921976,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))
22:22:03.006 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Code generated in 51.893181 ms
22:22:03.237 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Starting job: start at StreamingTest.scala:54
22:22:03.263 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Got job 0 (start at StreamingTest.scala:54) with 1 output partitions
22:22:03.264 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Final stage: ResultStage 0 (start at StreamingTest.scala:54)
22:22:03.264 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Parents of final stage: List()
22:22:03.266 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Missing parents: List()
22:22:03.274 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting ResultStage 0 (MapPartitionsRDD[4] at start at StreamingTest.scala:54), which has no missing parents
22:22:03.375 [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)
22:22:03.422 [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)
22:22:03.425 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Added broadcast_0_piece0 in memory on dist-test-slave-x101.c.gcp-upstream.internal:42565 (size: 7.8 KiB, free: 1993.9 MiB)
22:22:03.428 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Created broadcast 0 from broadcast at DAGScheduler.scala:1388
22:22:03.446 [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))
22:22:03.447 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Adding task set 0.0 with 1 tasks resource profile 0
22:22:03.530 [INFO - dispatcher-event-loop-1] (Logging.scala:57) Starting task 0.0 in stage 0.0 (TID 0) (dist-test-slave-x101.c.gcp-upstream.internal, executor driver, partition 0, PROCESS_LOCAL, 4803 bytes) taskResourceAssignments Map()
22:22:03.552 [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)
22:22:03.941 [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
22:22:03.946 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 42ddc4701aaf40c0ad9494670e3f2cb2
22:22:03.953 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 42ddc4701aaf40c0ad9494670e3f2cb2
22:22:03.960 [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'
22:22:03.980 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 390201e4dec24dc9b3918cf75bbe2675 for table 'simple-test' with partition [<start>, <end>)
22:22:03.982 [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@3857ab04, flushNotification=Deferred@1711654379(state=PENDING, result=null, callback=<none>, errback=<none>)}
22:22:03.980 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299988, tablet=390201e4dec24dc9b3918cf75bbe2675@[29c7e44ec92d4fa7961f2df5b7cd6a0a(127.2.15.131:42811)[L]]}]
22:22:03.998 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 390201e4dec24dc9b3918cf75bbe2675 for table 'simple-test' with partition [<start>, <end>)
22:22:03.999 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=390201e4dec24dc9b3918cf75bbe2675@[29c7e44ec92d4fa7961f2df5b7cd6a0a(127.2.15.131:42811)[L]]}]
22:22:04.001 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 390201e4dec24dc9b3918cf75bbe2675 for table 'simple-test' with partition [<start>, <end>)
22:22:04.001 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=390201e4dec24dc9b3918cf75bbe2675@[29c7e44ec92d4fa7961f2df5b7cd6a0a(127.2.15.131:42811)[L]]}]
22:22:04.015 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 29c7e44ec92d4fa7961f2df5b7cd6a0a(127.2.15.131:42811)] connecting to peer
22:22:04.022 [DEBUG - kudu-nio-1] (Connection.java:757) [peer 29c7e44ec92d4fa7961f2df5b7cd6a0a(127.2.15.131:42811)] Successfully connected to peer
22:22:04.053 [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
22:22:04.055 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xb7af14a4, L:/127.0.0.1:42594 - R:/127.2.15.131:42811] using TOKEN/null
22:22:04.089 [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 124ms
22:22:04.112 [INFO - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (Logging.scala:57) Finished task 0.0 in stage 0.0 (TID 0). 6753 bytes result sent to driver
22:22:04.124 [INFO - task-result-getter-0] (Logging.scala:57) Finished task 0.0 in stage 0.0 (TID 0) in 613 ms on dist-test-slave-x101.c.gcp-upstream.internal (executor driver) (1/1)
22:22:04.126 [INFO - task-result-getter-0] (Logging.scala:57) Removed TaskSet 0.0, whose tasks have all completed, from pool 
22:22:04.161 [INFO - dag-scheduler-event-loop] (Logging.scala:57) ResultStage 0 (start at StreamingTest.scala:54) finished in 0.871 s
22:22:04.166 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Job 0 is finished. Cancelling potential speculative or zombie tasks for this job
22:22:04.167 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Killing all running tasks in stage 0: Stage finished
22:22:04.170 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Job 0 finished: start at StreamingTest.scala:54, took 0.932067 s
22:22:04.172 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (KuduContext.scala:445) completed upsert ops: duration histogram: 124ms
22:22:04.192 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu7280221073061568760/commits/0 using temp file file:/tmp/spark_kudu7280221073061568760/commits/.0.705c7bd4-bfa6-47e8-936d-7e2396f9d699.tmp
22:22:04.217 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu7280221073061568760/commits/.0.705c7bd4-bfa6-47e8-936d-7e2396f9d699.tmp to file:/tmp/spark_kudu7280221073061568760/commits/0
22:22:04.232 [INFO - stream execution thread for [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8]] (Logging.scala:57) Streaming query made progress: {
  "id" : "64e01798-f5f9-467e-9803-1183c34a8e96",
  "runId" : "de2721d9-4b0a-47dd-9da1-c8e549ea31a8",
  "name" : null,
  "timestamp" : "2026-07-07T22:22:01.974Z",
  "batchId" : 0,
  "numInputRows" : 3,
  "inputRowsPerSecond" : 272.72727272727275,
  "processedRowsPerSecond" : 1.3363028953229399,
  "durationMs" : {
    "addBatch" : 1605,
    "getBatch" : 3,
    "latestOffset" : 0,
    "queryPlanning" : 522,
    "triggerExecution" : 2244,
    "walCommit" : 60
  },
  "stateOperators" : [ ],
  "sources" : [ {
    "description" : "MemoryStream[value#1]",
    "startOffset" : null,
    "endOffset" : 0,
    "numInputRows" : 3,
    "inputRowsPerSecond" : 272.72727272727275,
    "processedRowsPerSecond" : 1.3363028953229399
  } ],
  "sink" : {
    "description" : "org.apache.kudu.spark.kudu.KuduSink@8a2fc71",
    "numOutputRows" : -1
  }
}
22:22:04.247 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 42ddc4701aaf40c0ad9494670e3f2cb2
22:22:04.357 [INFO - main] (Logging.scala:57) Code generated in 17.470104 ms
22:22:04.458 [INFO - main] (Logging.scala:57) Starting job: collect at StreamingTest.scala:60
22:22:04.460 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Got job 1 (collect at StreamingTest.scala:60) with 1 output partitions
22:22:04.460 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Final stage: ResultStage 1 (collect at StreamingTest.scala:60)
22:22:04.460 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Parents of final stage: List()
22:22:04.460 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Missing parents: List()
22:22:04.462 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting ResultStage 1 (MapPartitionsRDD[11] at map at StreamingTest.scala:60), which has no missing parents
22:22:04.469 [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)
22:22:04.471 [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)
22:22:04.472 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Added broadcast_1_piece0 in memory on dist-test-slave-x101.c.gcp-upstream.internal:42565 (size: 9.1 KiB, free: 1993.9 MiB)
22:22:04.472 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Created broadcast 1 from broadcast at DAGScheduler.scala:1388
22:22:04.473 [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))
22:22:04.473 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Adding task set 1.0 with 1 tasks resource profile 0
22:22:04.478 [INFO - dispatcher-event-loop-0] (Logging.scala:57) Starting task 0.0 in stage 1.0 (TID 1) (dist-test-slave-x101.c.gcp-upstream.internal, executor driver, partition 0, ANY, 4796 bytes) taskResourceAssignments Map()
22:22:04.479 [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)
22:22:04.577 [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
22:22:04.623 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Code generated in 13.78026 ms
22:22:04.673 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305064139385491456) for scanner KuduScanner(table=simple-test, tablet=390201e4dec24dc9b3918cf75bbe2675, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
22:22:04.743 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Code generated in 52.677729 ms
22:22:04.749 [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). 5413 bytes result sent to driver
22:22:04.754 [INFO - task-result-getter-1] (Logging.scala:57) Finished task 0.0 in stage 1.0 (TID 1) in 276 ms on dist-test-slave-x101.c.gcp-upstream.internal (executor driver) (1/1)
22:22:04.755 [INFO - dag-scheduler-event-loop] (Logging.scala:57) ResultStage 1 (collect at StreamingTest.scala:60) finished in 0.290 s
22:22:04.756 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Job 1 is finished. Cancelling potential speculative or zombie tasks for this job
22:22:04.757 [INFO - task-result-getter-1] (Logging.scala:57) Removed TaskSet 1.0, whose tasks have all completed, from pool 
22:22:04.757 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Killing all running tasks in stage 1: Stage finished
22:22:04.757 [INFO - main] (Logging.scala:57) Job 1 finished: collect at StreamingTest.scala:60, took 0.298411 s
22:22:04.760 [INFO - main] (Logging.scala:57) Asked to cancel job group de2721d9-4b0a-47dd-9da1-c8e549ea31a8
22:22:04.777 [INFO - main] (Logging.scala:57) Asked to cancel job group de2721d9-4b0a-47dd-9da1-c8e549ea31a8
22:22:04.778 [INFO - main] (Logging.scala:57) Query [id = 64e01798-f5f9-467e-9803-1183c34a8e96, runId = de2721d9-4b0a-47dd-9da1-c8e549ea31a8] was stopped
22:22:04.801 [INFO - dispatcher-event-loop-0] (Logging.scala:57) MapOutputTrackerMasterEndpoint stopped!
22:22:04.814 [INFO - main] (Logging.scala:57) MemoryStore cleared
22:22:04.815 [INFO - main] (Logging.scala:57) BlockManager stopped
22:22:04.826 [INFO - main] (Logging.scala:57) BlockManagerMaster stopped
22:22:04.829 [INFO - dispatcher-event-loop-1] (Logging.scala:57) OutputCommitCoordinator stopped!
22:22:04.834 [INFO - main] (Logging.scala:57) Successfully stopped SparkContext
22:22:04.837 [DEBUG - main] (Connection.java:575) [peer master-127.2.15.189:33075(127.2.15.189:33075)] disconnecting while in state READY
22:22:04.838 [DEBUG - main] (Connection.java:575) [peer master-127.2.15.188:35115(127.2.15.188:35115)] disconnecting while in state READY
22:22:04.838 [DEBUG - main] (Connection.java:575) [peer master-127.2.15.190:44541(127.2.15.190:44541)] disconnecting while in state READY
22:22:04.839 [DEBUG - main] (Connection.java:575) [peer 29c7e44ec92d4fa7961f2df5b7cd6a0a(127.2.15.131:42811)] disconnecting while in state READY
22:22:04.846 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2704) Releasing all remaining resources
22:22:04.847 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.2.15.190:44541(127.2.15.190:44541)] handling channelInactive
22:22:04.848 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.2.15.190:44541(127.2.15.190:44541)] cleaning up while in state READY due to: connection closed
22:22:04.848 [DEBUG - kudu-nio-1] (Connection.java:239) [peer 29c7e44ec92d4fa7961f2df5b7cd6a0a(127.2.15.131:42811)] handling channelInactive
22:22:04.848 [DEBUG - kudu-nio-1] (Connection.java:709) [peer 29c7e44ec92d4fa7961f2df5b7cd6a0a(127.2.15.131:42811)] cleaning up while in state READY due to: connection closed
22:22:04.849 [DEBUG - kudu-nio-1] (PoolThreadCache.java:221) Freed 22 thread-local buffer(s) from thread: kudu-nio-1
22:22:04.851 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.2.15.189:33075(127.2.15.189:33075)] handling channelInactive
22:22:04.851 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.2.15.189:33075(127.2.15.189:33075)] cleaning up while in state READY due to: connection closed
22:22:04.851 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.2.15.188:35115(127.2.15.188:35115)] handling channelInactive
22:22:04.852 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.2.15.188:35115(127.2.15.188:35115)] cleaning up while in state READY due to: connection closed
22:22:04.852 [DEBUG - kudu-nio-0] (PoolThreadCache.java:221) Freed 31 thread-local buffer(s) from thread: kudu-nio-0
22:22:04.864 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
22:22:04.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:22:04.865046  2110 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskz_BPic/build/debug/bin/kudu with pid 2394
22:22:04.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:22:04.871889  2110 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskz_BPic/build/debug/bin/kudu with pid 2532
22:22:04.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:22:04.878995  2110 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskz_BPic/build/debug/bin/kudu with pid 2667
22:22:04.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:22:04.885802  2110 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskz_BPic/build/debug/bin/kudu with pid 2121
22:22:04.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:22:04.892315  2110 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskz_BPic/build/debug/bin/kudu with pid 2192
22:22:04.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 22:22:04.898049  2110 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskz_BPic/build/debug/bin/kudu with pid 2263
22:22:04.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T22:22:04Z chronyd exiting

Time: 13.134

OK (1 test)

22:22:05.217 [INFO - shutdown-hook-0] (Logging.scala:57) Shutdown hook called
22:22:05.218 [INFO - shutdown-hook-0] (Logging.scala:57) Deleting directory /tmp/spark-06dbfb14-87c2-42de-b90f-00ac2407d530
