JUnit version 4.13.2
.00:31:22.217 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783470682208
00:31:22.245 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
00:31:22.282 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
00:31:22.290 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task_7Q1t0/test-tmp
00:31:22.320 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
00:31:22.324 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task_7Q1t0/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
00:31:22.535 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

00:31:22.547 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
00:31:22.548 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

00:31:22.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.549664 18323 mini_oidc.cc:150] Starting JWKS server
00:31:22.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.550396 18323 webserver.cc:534] Webserver started at http://127.0.0.1:36779/ using document root <none> and password file <none>
00:31:22.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.550494 18323 mini_oidc.cc:186] Starting OIDC Discovery server
00:31:22.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.551438 18323 webserver.cc:534] Webserver started at http://127.0.0.1:35773/ using document root <none> and password file <none>
00:31:22.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T00:31:22Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
00:31:22.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T00:31:22Z Disabled control of system clock
00:31:22.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.562768 18323 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:22.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:22.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/wal
00:31:22.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/data
00:31:22.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
00:31:22.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
00:31:22.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
00:31:22.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:22.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:22.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:22.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/logs
00:31:22.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/data/info.pb
00:31:22.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:22.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
00:31:22.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
00:31:22.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
00:31:22.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
00:31:22.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:22.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:22.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:22.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
00:31:22.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
00:31:22.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
00:31:22.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
00:31:22.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.254:37431
00:31:22.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.254
00:31:22.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:22.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:22.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:22.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:22.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
00:31:22.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
00:31:22.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:22.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
00:31:22.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36779/jwks.json with env {}
00:31:22.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.657387 18334 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
00:31:22.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.657529 18334 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
00:31:22.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.657546 18334 flags.cc:432] Enabled unsafe flag: --never_fsync=true
00:31:22.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.659042 18334 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
00:31:22.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.659081 18334 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
00:31:22.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.659094 18334 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
00:31:22.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.659104 18334 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
00:31:22.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.659114 18334 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
00:31:22.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.659124 18334 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36779/jwks.json
00:31:22.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.660840 18334 master_runner.cc:387] Master server non-default flags:
00:31:22.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:22.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:22.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:22.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
00:31:22.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/data
00:31:22.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/wal
00:31:22.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
00:31:22.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:22.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:22.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:22.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
00:31:22.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.254:37431
00:31:22.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
00:31:22.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
00:31:22.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
00:31:22.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36779/jwks.json
00:31:22.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:22.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:22.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/data/info.pb
00:31:22.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.254
00:31:22.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:22.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
00:31:22.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18334
00:31:22.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:22.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
00:31:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
00:31:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/logs
00:31:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
00:31:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
00:31:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
00:31:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
00:31:22.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 0d8247991d193c4f984e0c0bdfb0389121fdc8d9
00:31:22.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
00:31:22.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 00:13:03 UTC on e7f111948823
00:31:22.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16841
00:31:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.661026 18334 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
00:31:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.661204 18334 file_cache.cc:492] Constructed file cache file cache with capacity 419430
00:31:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.663493 18342 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
00:31:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.663578 18334 server_base.cc:1061] running on GCE node
00:31:22.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.663640 18339 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
00:31:22.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.663546 18340 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
00:31:22.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.663861 18334 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
00:31:22.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.664119 18334 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
00:31:22.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.665256 18334 hybrid_clock.cc:648] HybridClock initialized: now 1783470682665234 us; error 33 us; skew 500 ppm
00:31:22.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.666121 18334 webserver.cc:534] Webserver started at http://127.17.228.254:46083/ using document root <none> and password file <none>
00:31:22.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.666275 18334 fs_manager.cc:362] Metadata directory not provided
00:31:22.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.666320 18334 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
00:31:22.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.666411 18334 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
00:31:22.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.667459 18334 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/data/instance:
00:31:22.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8a53157dfb7f4c36ba1d8de1c762652c"
00:31:22.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:22 on dist-test-slave-bwrj"
00:31:22.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.667806 18334 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/wal/instance:
00:31:22.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8a53157dfb7f4c36ba1d8de1c762652c"
00:31:22.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:22 on dist-test-slave-bwrj"
00:31:22.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.669274 18334 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.002s
00:31:22.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.669996 18348 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
00:31:22.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.670163 18334 fs_manager.cc:730] Time spent opening block manager: real 0.000s	user 0.000s	sys 0.001s
00:31:22.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.670225 18334 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/data,/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/wal
00:31:22.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8a53157dfb7f4c36ba1d8de1c762652c"
00:31:22.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:22 on dist-test-slave-bwrj"
00:31:22.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.670275 18334 fs_report.cc:389] FS layout report
00:31:22.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
00:31:22.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/wal
00:31:22.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/wal
00:31:22.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/data/data
00:31:22.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
00:31:22.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
00:31:22.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
00:31:22.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
00:31:22.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
00:31:22.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
00:31:22.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
00:31:22.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
00:31:22.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
00:31:22.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
00:31:22.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
00:31:22.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.687425 18334 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
00:31:22.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.687703 18334 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
00:31:22.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.687824 18334 kserver.cc:163] Server-wide thread pool size limit: 3276
00:31:22.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.691494 18334 rpc_server.cc:307] RPC server started. Bound to: 127.17.228.254:37431
00:31:22.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.691524 18400 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.228.254:37431 every 8 connection(s)
00:31:22.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.691852 18334 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/data/info.pb
00:31:22.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.692375 18401 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
00:31:22.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.692924 18323 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_7Q1t0/build/release/bin/kudu as pid 18334
00:31:22.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.692996 18323 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-0/wal/instance
00:31:22.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.693605 18323 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:22.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:22.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/wal
00:31:22.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/data
00:31:22.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
00:31:22.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
00:31:22.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
00:31:22.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:22.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:22.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:22.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/logs
00:31:22.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/data/info.pb
00:31:22.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:22.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
00:31:22.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
00:31:22.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
00:31:22.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
00:31:22.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:22.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:22.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:22.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
00:31:22.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
00:31:22.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
00:31:22.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
00:31:22.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.253:33381
00:31:22.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.253
00:31:22.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:22.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:22.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:22.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:22.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
00:31:22.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
00:31:22.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:22.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
00:31:22.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36779/jwks.json with env {}
00:31:22.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.693761 18401 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } has no permanent_uuid. Determining permanent_uuid...
00:31:22.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.699875 18401 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } has no permanent_uuid. Determining permanent_uuid...
00:31:22.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.700187 18352 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.17.228.253:33381: connect: Connection refused (error 111)
00:31:22.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.702905 18401 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.228.253:33381: Network error: Client connection negotiation failed: client connection to 127.17.228.253:33381: connect: Connection refused (error 111)
00:31:22.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.752081 18401 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } attempt: 1
00:31:22.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.752902 18401 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.228.253:33381: Network error: Client connection negotiation failed: client connection to 127.17.228.253:33381: connect: Connection refused (error 111)
00:31:22.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.766471 18403 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
00:31:22.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.766640 18403 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
00:31:22.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.766661 18403 flags.cc:432] Enabled unsafe flag: --never_fsync=true
00:31:22.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.768083 18403 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
00:31:22.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.768121 18403 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
00:31:22.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.768132 18403 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
00:31:22.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.768142 18403 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
00:31:22.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.768154 18403 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
00:31:22.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.768164 18403 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36779/jwks.json
00:31:22.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.770112 18403 master_runner.cc:387] Master server non-default flags:
00:31:22.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:22.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:22.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:22.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
00:31:22.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/data
00:31:22.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/wal
00:31:22.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
00:31:22.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:22.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:22.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:22.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
00:31:22.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.253:33381
00:31:22.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
00:31:22.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
00:31:22.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
00:31:22.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36779/jwks.json
00:31:22.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:22.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:22.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/data/info.pb
00:31:22.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.253
00:31:22.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:22.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
00:31:22.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18403
00:31:22.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:22.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
00:31:22.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
00:31:22.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:22.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/logs
00:31:22.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:22.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
00:31:22.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
00:31:22.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
00:31:22.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
00:31:22.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 0d8247991d193c4f984e0c0bdfb0389121fdc8d9
00:31:22.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
00:31:22.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 00:13:03 UTC on e7f111948823
00:31:22.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16841
00:31:22.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.770347 18403 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
00:31:22.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.770567 18403 file_cache.cc:492] Constructed file cache file cache with capacity 419430
00:31:22.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.772768 18414 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
00:31:22.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.772800 18412 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
00:31:22.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.773452 18411 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
00:31:22.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.773530 18403 server_base.cc:1061] running on GCE node
00:31:22.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.773699 18403 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
00:31:22.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.773947 18403 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
00:31:22.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.775080 18403 hybrid_clock.cc:648] HybridClock initialized: now 1783470682775060 us; error 29 us; skew 500 ppm
00:31:22.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.776978 18403 webserver.cc:534] Webserver started at http://127.17.228.253:40967/ using document root <none> and password file <none>
00:31:22.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.777149 18403 fs_manager.cc:362] Metadata directory not provided
00:31:22.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.777200 18403 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
00:31:22.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.777295 18403 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
00:31:22.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.778264 18403 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/data/instance:
00:31:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e222c6f5b48c47d2bf41838a8b72907e"
00:31:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:22 on dist-test-slave-bwrj"
00:31:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.778618 18403 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/wal/instance:
00:31:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e222c6f5b48c47d2bf41838a8b72907e"
00:31:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:22 on dist-test-slave-bwrj"
00:31:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.780205 18403 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.001s	sys 0.000s
00:31:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.781630 18420 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
00:31:22.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.781787 18403 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
00:31:22.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.781852 18403 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/data,/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/wal
00:31:22.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e222c6f5b48c47d2bf41838a8b72907e"
00:31:22.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:22 on dist-test-slave-bwrj"
00:31:22.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.781900 18403 fs_report.cc:389] FS layout report
00:31:22.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
00:31:22.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/wal
00:31:22.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/wal
00:31:22.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/data/data
00:31:22.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
00:31:22.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
00:31:22.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
00:31:22.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
00:31:22.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
00:31:22.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
00:31:22.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
00:31:22.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
00:31:22.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
00:31:22.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
00:31:22.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
00:31:22.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.806183 18403 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
00:31:22.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.806475 18403 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
00:31:22.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.806627 18403 kserver.cc:163] Server-wide thread pool size limit: 3276
00:31:22.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.810185 18403 rpc_server.cc:307] RPC server started. Bound to: 127.17.228.253:33381
00:31:22.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.810218 18472 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.228.253:33381 every 8 connection(s)
00:31:22.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.810540 18403 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/data/info.pb
00:31:22.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.811170 18473 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
00:31:22.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.812321 18473 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } has no permanent_uuid. Determining permanent_uuid...
00:31:22.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.816265 18473 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } has no permanent_uuid. Determining permanent_uuid...
00:31:22.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.817690 18323 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_7Q1t0/build/release/bin/kudu as pid 18403
00:31:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.817761 18323 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-1/wal/instance
00:31:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.818075 18323 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/wal
00:31:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/data
00:31:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
00:31:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
00:31:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
00:31:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/logs
00:31:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/data/info.pb
00:31:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:22.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
00:31:22.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
00:31:22.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
00:31:22.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
00:31:22.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:22.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:22.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:22.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
00:31:22.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
00:31:22.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
00:31:22.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
00:31:22.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.252:35941
00:31:22.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.252
00:31:22.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:22.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:22.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:22.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:22.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
00:31:22.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
00:31:22.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:22.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
00:31:22.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36779/jwks.json with env {}
00:31:22.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.821118 18473 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } has no permanent_uuid. Determining permanent_uuid...
00:31:22.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.821440 18424 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.17.228.252:35941: connect: Connection refused (error 111)
00:31:22.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.822263 18401 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } attempt: 2
00:31:22.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.825250 18401 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } has no permanent_uuid. Determining permanent_uuid...
00:31:22.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.825739 18401 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.228.252:35941: Network error: Client connection negotiation failed: client connection to 127.17.228.252:35941: connect: Connection refused (error 111)
00:31:22.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.826614 18473 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.228.252:35941: Network error: Client connection negotiation failed: client connection to 127.17.228.252:35941: connect: Connection refused (error 111)
00:31:22.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.868860 18401 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } attempt: 1
00:31:22.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.869554 18401 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.228.252:35941: Network error: Client connection negotiation failed: client connection to 127.17.228.252:35941: connect: Connection refused (error 111)
00:31:22.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.875787 18473 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } attempt: 1
00:31:22.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.876451 18473 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.228.252:35941: Network error: Client connection negotiation failed: client connection to 127.17.228.252:35941: connect: Connection refused (error 111)
00:31:22.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.895902 18477 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
00:31:22.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.896044 18477 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
00:31:22.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.896062 18477 flags.cc:432] Enabled unsafe flag: --never_fsync=true
00:31:22.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.898109 18477 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
00:31:22.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.898161 18477 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
00:31:22.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.898180 18477 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
00:31:22.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.898193 18477 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
00:31:22.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.898213 18477 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
00:31:22.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.898227 18477 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36779/jwks.json
00:31:22.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.899724 18477 master_runner.cc:387] Master server non-default flags:
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/data
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/wal
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
00:31:22.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.252:35941
00:31:22.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
00:31:22.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
00:31:22.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
00:31:22.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36779/jwks.json
00:31:22.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:22.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:22.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/data/info.pb
00:31:22.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.252
00:31:22.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:22.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
00:31:22.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18477
00:31:22.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:22.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
00:31:22.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
00:31:22.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:22.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/logs
00:31:22.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:22.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
00:31:22.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
00:31:22.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
00:31:22.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
00:31:22.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 0d8247991d193c4f984e0c0bdfb0389121fdc8d9
00:31:22.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
00:31:22.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 00:13:03 UTC on e7f111948823
00:31:22.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16841
00:31:22.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.899893 18477 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
00:31:22.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.900053 18477 file_cache.cc:492] Constructed file cache file cache with capacity 419430
00:31:22.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.902019 18483 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
00:31:22.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.902041 18484 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
00:31:22.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.902467 18477 server_base.cc:1061] running on GCE node
00:31:22.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.902019 18486 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
00:31:22.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.902756 18477 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
00:31:22.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.903015 18477 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
00:31:22.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.904161 18477 hybrid_clock.cc:648] HybridClock initialized: now 1783470682904150 us; error 37 us; skew 500 ppm
00:31:22.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.905085 18477 webserver.cc:534] Webserver started at http://127.17.228.252:38783/ using document root <none> and password file <none>
00:31:22.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.905234 18477 fs_manager.cc:362] Metadata directory not provided
00:31:22.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.905265 18477 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
00:31:22.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.905339 18477 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
00:31:22.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.906311 18477 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/data/instance:
00:31:22.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5b12c71601f6481ba7ead23e6bb5ed35"
00:31:22.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:22 on dist-test-slave-bwrj"
00:31:22.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.906687 18477 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/wal/instance:
00:31:22.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5b12c71601f6481ba7ead23e6bb5ed35"
00:31:22.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:22 on dist-test-slave-bwrj"
00:31:22.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.910843 18477 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.000s	sys 0.001s
00:31:22.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.911594 18492 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
00:31:22.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.911759 18477 fs_manager.cc:730] Time spent opening block manager: real 0.000s	user 0.000s	sys 0.001s
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.911818 18477 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/data,/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/wal
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5b12c71601f6481ba7ead23e6bb5ed35"
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:22 on dist-test-slave-bwrj"
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.911870 18477 fs_report.cc:389] FS layout report
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/wal
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/wal
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/data/data
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
00:31:22.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
00:31:22.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
00:31:22.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
00:31:22.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
00:31:22.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
00:31:22.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
00:31:22.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.916706 18401 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } attempt: 2
00:31:22.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.917410 18401 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.17.228.252:35941: Network error: Client connection negotiation failed: client connection to 127.17.228.252:35941: connect: Connection refused (error 111)
00:31:22.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.927825 18477 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
00:31:22.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.928058 18477 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
00:31:22.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.928135 18477 kserver.cc:163] Server-wide thread pool size limit: 3276
00:31:22.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.931574 18477 rpc_server.cc:307] RPC server started. Bound to: 127.17.228.252:35941
00:31:22.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.931603 18545 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.228.252:35941 every 8 connection(s)
00:31:22.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.931846 18477 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/data/info.pb
00:31:22.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.932331 18546 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
00:31:22.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.933550 18546 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } has no permanent_uuid. Determining permanent_uuid...
00:31:22.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.938097 18546 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } has no permanent_uuid. Determining permanent_uuid...
00:31:22.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.940757 18546 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } has no permanent_uuid. Determining permanent_uuid...
00:31:22.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.941951 18323 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_7Q1t0/build/release/bin/kudu as pid 18477
00:31:22.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.942035 18323 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/master-2/wal/instance
00:31:22.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.944479 18546 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35: Bootstrap starting.
00:31:22.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.944809 18473 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } attempt: 2
00:31:22.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.945271 18546 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35: Neither blocks nor log segments found. Creating new log.
00:31:22.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.945521 18546 log.cc:826] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35: Log is configured to *not* fsync() on all Append() calls
00:31:22.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.946986 18546 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35: No bootstrap required, opened a new log
00:31:22.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.948609 18546 raft_consensus.cc:359] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } }
00:31:22.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.948714 18546 raft_consensus.cc:385] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
00:31:22.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.948741 18546 raft_consensus.cc:740] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 5b12c71601f6481ba7ead23e6bb5ed35, State: Initialized, Role: FOLLOWER
00:31:22.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.948850 18546 consensus_queue.cc:260] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [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: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } }
00:31:22.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.949134 18546 sys_catalog.cc:565] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [sys.catalog]: configured and running, proceeding with master startup.
00:31:22.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.949836 18553 sys_catalog.cc:455] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [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: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } } }
00:31:22.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.950169 18553 sys_catalog.cc:458] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [sys.catalog]: This master's current role is: FOLLOWER
00:31:22.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.952294 18473 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e: Bootstrap starting.
00:31:22.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.952883 18473 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e: Neither blocks nor log segments found. Creating new log.
00:31:22.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.951620 18477 master_runner.cc:187] Error getting master registration for 127.17.228.254:37431: OK, instance_id { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" instance_seqno: 1783470682690517 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
00:31:22.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.953078 18477 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
00:31:22.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.953146 18473 log.cc:826] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e: Log is configured to *not* fsync() on all Append() calls
00:31:22.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.950922 18564 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
00:31:22.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.954214 18564 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
00:31:22.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.954823 18473 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e: No bootstrap required, opened a new log
00:31:22.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.956355 18473 raft_consensus.cc:359] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } }
00:31:22.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.956441 18473 raft_consensus.cc:385] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
00:31:22.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.956460 18473 raft_consensus.cc:740] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e222c6f5b48c47d2bf41838a8b72907e, State: Initialized, Role: FOLLOWER
00:31:22.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.956521 18473 consensus_queue.cc:260] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [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: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } }
00:31:22.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.956770 18473 sys_catalog.cc:565] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [sys.catalog]: configured and running, proceeding with master startup.
00:31:22.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.958179 18567 sys_catalog.cc:455] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [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: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } } }
00:31:22.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.958714 18567 sys_catalog.cc:458] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [sys.catalog]: This master's current role is: FOLLOWER
00:31:22.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.959604 18578 catalog_manager.cc:1593] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
00:31:22.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:22.959646 18578 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
00:31:22.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.958796 18403 master_runner.cc:187] Error getting master registration for 127.17.228.254:37431: OK, instance_id { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" instance_seqno: 1783470682690517 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
00:31:22.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:22.960461 18403 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
00:31:23.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.024566 18401 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } attempt: 3
00:31:23.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.028985 18401 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c: Bootstrap starting.
00:31:23.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.029646 18401 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c: Neither blocks nor log segments found. Creating new log.
00:31:23.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.029884 18401 log.cc:826] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c: Log is configured to *not* fsync() on all Append() calls
00:31:23.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.030471 18401 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c: No bootstrap required, opened a new log
00:31:23.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.032569 18401 raft_consensus.cc:359] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } }
00:31:23.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.032682 18401 raft_consensus.cc:385] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
00:31:23.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.032709 18401 raft_consensus.cc:740] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 8a53157dfb7f4c36ba1d8de1c762652c, State: Initialized, Role: FOLLOWER
00:31:23.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.032788 18401 consensus_queue.cc:260] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [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: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } }
00:31:23.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.033061 18401 sys_catalog.cc:565] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [sys.catalog]: configured and running, proceeding with master startup.
00:31:23.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.034090 18581 sys_catalog.cc:455] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [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: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } } }
00:31:23.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.034471 18581 sys_catalog.cc:458] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [sys.catalog]: This master's current role is: FOLLOWER
00:31:23.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.035393 18592 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
00:31:23.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.035737 18592 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
00:31:23.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.037217 18334 master_runner.cc:264] No leader master found from master 8a53157dfb7f4c36ba1d8de1c762652c
00:31:23.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.037269 18334 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
00:31:23.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.057411 18426 tablet.cc:2406] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e: Can't schedule compaction. Clean time has not been advanced past its initial value.
00:31:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.081676 18581 raft_consensus.cc:493] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
00:31:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.081787 18581 raft_consensus.cc:515] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } }
00:31:23.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.082090 18581 leader_election.cc:290] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers e222c6f5b48c47d2bf41838a8b72907e (127.17.228.253:33381), 5b12c71601f6481ba7ead23e6bb5ed35 (127.17.228.252:35941)
00:31:23.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.083254 18447 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e222c6f5b48c47d2bf41838a8b72907e" is_pre_election: true
00:31:23.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.083436 18447 raft_consensus.cc:2468] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 8a53157dfb7f4c36ba1d8de1c762652c in term 0.
00:31:23.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.083634 18520 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" is_pre_election: true
00:31:23.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.083743 18520 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 8a53157dfb7f4c36ba1d8de1c762652c in term 0.
00:31:23.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.084008 18352 leader_election.cc:304] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [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: 5b12c71601f6481ba7ead23e6bb5ed35, 8a53157dfb7f4c36ba1d8de1c762652c; no voters: 
00:31:23.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.084168 18581 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [term 0 FOLLOWER]: Leader pre-election won for term 1
00:31:23.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.084210 18581 raft_consensus.cc:493] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
00:31:23.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.084231 18581 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [term 0 FOLLOWER]: Advancing to term 1
00:31:23.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.085320 18581 raft_consensus.cc:515] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } }
00:31:23.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.085433 18581 leader_election.cc:290] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [CANDIDATE]: Term 1 election: Requested vote from peers e222c6f5b48c47d2bf41838a8b72907e (127.17.228.253:33381), 5b12c71601f6481ba7ead23e6bb5ed35 (127.17.228.252:35941)
00:31:23.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.085660 18447 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e222c6f5b48c47d2bf41838a8b72907e"
00:31:23.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.085722 18447 raft_consensus.cc:3060] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [term 0 FOLLOWER]: Advancing to term 1
00:31:23.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.086504 18447 raft_consensus.cc:2468] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 8a53157dfb7f4c36ba1d8de1c762652c in term 1.
00:31:23.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.086711 18520 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5b12c71601f6481ba7ead23e6bb5ed35"
00:31:23.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.086777 18520 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [term 0 FOLLOWER]: Advancing to term 1
00:31:23.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.087519 18520 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 8a53157dfb7f4c36ba1d8de1c762652c in term 1.
00:31:23.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.089792 18352 leader_election.cc:304] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [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: 8a53157dfb7f4c36ba1d8de1c762652c, e222c6f5b48c47d2bf41838a8b72907e; no voters: 
00:31:23.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.089907 18581 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [term 1 FOLLOWER]: Leader election won for term 1
00:31:23.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.090062 18581 raft_consensus.cc:697] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [term 1 LEADER]: Becoming Leader. State: Replica: 8a53157dfb7f4c36ba1d8de1c762652c, State: Running, Role: LEADER
00:31:23.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.090143 18581 consensus_queue.cc:237] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [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: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } }
00:31:23.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.090526 18581 sys_catalog.cc:455] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [sys.catalog]: SysCatalogTable state changed. Reason: New leader 8a53157dfb7f4c36ba1d8de1c762652c. Latest consensus state: current_term: 1 leader_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } } }
00:31:23.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.090659 18581 sys_catalog.cc:458] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [sys.catalog]: This master's current role is: LEADER
00:31:23.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.092132 18596 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
00:31:23.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.092586 18596 catalog_manager.cc:1519] Initializing Kudu cluster ID...
00:31:23.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.094945 18520 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [term 1 FOLLOWER]: Refusing update from remote peer 8a53157dfb7f4c36ba1d8de1c762652c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
00:31:23.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.095602 18581 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [LEADER]: Connected to new peer: Peer: permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
00:31:23.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.096612 18553 sys_catalog.cc:455] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 8a53157dfb7f4c36ba1d8de1c762652c. Latest consensus state: current_term: 1 leader_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } } }
00:31:23.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.096678 18553 sys_catalog.cc:458] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [sys.catalog]: This master's current role is: FOLLOWER
00:31:23.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.097961 18447 raft_consensus.cc:1275] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [term 1 FOLLOWER]: Refusing update from remote peer 8a53157dfb7f4c36ba1d8de1c762652c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
00:31:23.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.098158 18581 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [LEADER]: Connected to new peer: Peer: permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
00:31:23.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.099143 18567 sys_catalog.cc:455] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [sys.catalog]: SysCatalogTable state changed. Reason: New leader 8a53157dfb7f4c36ba1d8de1c762652c. Latest consensus state: current_term: 1 leader_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } } }
00:31:23.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.099215 18567 sys_catalog.cc:458] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [sys.catalog]: This master's current role is: FOLLOWER
00:31:23.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.100883 18594 sys_catalog.cc:455] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } } }
00:31:23.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.100970 18594 sys_catalog.cc:458] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [sys.catalog]: This master's current role is: LEADER
00:31:23.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.101783 18567 sys_catalog.cc:455] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } } }
00:31:23.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.101853 18567 sys_catalog.cc:458] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e [sys.catalog]: This master's current role is: FOLLOWER
00:31:23.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.102406 18597 mvcc.cc:204] Tried to move back new op lower bound from 7305095917954506752 to 7305095917937778688. Current Snapshot: MvccSnapshot[applied={T|T < 7305095917954506752}]
00:31:23.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.102778 18600 mvcc.cc:204] Tried to move back new op lower bound from 7305095917954506752 to 7305095917937778688. Current Snapshot: MvccSnapshot[applied={T|T < 7305095917954506752}]
00:31:23.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.103636 18581 sys_catalog.cc:455] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } } }
00:31:23.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.103706 18581 sys_catalog.cc:458] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c [sys.catalog]: This master's current role is: LEADER
00:31:23.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.104483 18553 sys_catalog.cc:455] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a53157dfb7f4c36ba1d8de1c762652c" member_type: VOTER last_known_addr { host: "127.17.228.254" port: 37431 } } peers { permanent_uuid: "e222c6f5b48c47d2bf41838a8b72907e" member_type: VOTER last_known_addr { host: "127.17.228.253" port: 33381 } } peers { permanent_uuid: "5b12c71601f6481ba7ead23e6bb5ed35" member_type: VOTER last_known_addr { host: "127.17.228.252" port: 35941 } } }
00:31:23.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.104561 18553 sys_catalog.cc:458] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35 [sys.catalog]: This master's current role is: FOLLOWER
00:31:23.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.105803 18596 catalog_manager.cc:1382] Generated new cluster ID: 76077157a722413199712745c6639ae7
00:31:23.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.105842 18596 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
00:31:23.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.129037 18596 catalog_manager.cc:1405] Generated new certificate authority record
00:31:23.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.130188 18596 catalog_manager.cc:1539] Loading token signing keys...
00:31:23.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.139580 18596 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 8a53157dfb7f4c36ba1d8de1c762652c: Generated new TSK 0
00:31:23.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.140030 18596 catalog_manager.cc:1549] Initializing in-progress tserver states...
00:31:23.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.149361 18323 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:23.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:23.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/wal
00:31:23.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/data
00:31:23.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/logs
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/data/info.pb
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:23.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
00:31:23.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
00:31:23.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.193:0
00:31:23.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.228.193
00:31:23.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.193
00:31:23.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:23.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:23.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:23.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:23.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:23.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
00:31:23.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.242403 18606 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
00:31:23.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.242561 18606 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
00:31:23.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.242587 18606 flags.cc:432] Enabled unsafe flag: --never_fsync=true
00:31:23.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.244748 18606 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
00:31:23.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.244807 18606 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.228.193
00:31:23.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.246419 18606 tablet_server_runner.cc:78] Tablet server non-default flags:
00:31:23.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:23.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:23.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/data
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/wal
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.193:0
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/data/info.pb
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.193
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:23.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18606
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.228.193
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/logs
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
00:31:23.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
00:31:23.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 0d8247991d193c4f984e0c0bdfb0389121fdc8d9
00:31:23.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
00:31:23.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 00:13:03 UTC on e7f111948823
00:31:23.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16841
00:31:23.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.246667 18606 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
00:31:23.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.246940 18606 file_cache.cc:492] Constructed file cache file cache with capacity 419430
00:31:23.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.250890 18611 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
00:31:23.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.251338 18614 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
00:31:23.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.251549 18606 server_base.cc:1061] running on GCE node
00:31:23.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.250870 18612 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
00:31:23.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.252136 18606 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
00:31:23.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.252360 18606 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
00:31:23.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.253487 18606 hybrid_clock.cc:648] HybridClock initialized: now 1783470683253469 us; error 30 us; skew 500 ppm
00:31:23.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.254596 18606 webserver.cc:534] Webserver started at http://127.17.228.193:46433/ using document root <none> and password file <none>
00:31:23.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.254773 18606 fs_manager.cc:362] Metadata directory not provided
00:31:23.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.254817 18606 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
00:31:23.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.254904 18606 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
00:31:23.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.255822 18606 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/data/instance:
00:31:23.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "db417f5f03a84716aa7d9cd6efe37fc6"
00:31:23.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:23 on dist-test-slave-bwrj"
00:31:23.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.256073 18606 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/wal/instance:
00:31:23.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "db417f5f03a84716aa7d9cd6efe37fc6"
00:31:23.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:23 on dist-test-slave-bwrj"
00:31:23.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.257010 18606 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.001s
00:31:23.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.257531 18620 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
00:31:23.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.257754 18606 fs_manager.cc:730] Time spent opening block manager: real 0.000s	user 0.000s	sys 0.000s
00:31:23.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.257817 18606 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/data,/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/wal
00:31:23.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "db417f5f03a84716aa7d9cd6efe37fc6"
00:31:23.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:23 on dist-test-slave-bwrj"
00:31:23.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.257869 18606 fs_report.cc:389] FS layout report
00:31:23.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
00:31:23.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/wal
00:31:23.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/wal
00:31:23.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/data/data
00:31:23.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
00:31:23.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
00:31:23.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
00:31:23.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
00:31:23.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
00:31:23.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
00:31:23.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
00:31:23.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
00:31:23.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
00:31:23.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
00:31:23.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
00:31:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.277956 18606 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
00:31:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.278255 18606 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
00:31:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.278364 18606 kserver.cc:163] Server-wide thread pool size limit: 3276
00:31:23.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.278615 18606 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
00:31:23.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.279026 18606 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
00:31:23.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.279064 18606 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
00:31:23.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.279093 18606 ts_tablet_manager.cc:616] Registered 0 tablets
00:31:23.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.279109 18606 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
00:31:23.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.284365 18606 rpc_server.cc:307] RPC server started. Bound to: 127.17.228.193:38689
00:31:23.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.284432 18734 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.228.193:38689 every 8 connection(s)
00:31:23.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.284718 18606 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/data/info.pb
00:31:23.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.289479 18736 heartbeater.cc:344] Connected to a master server at 127.17.228.254:37431
00:31:23.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.289565 18736 heartbeater.cc:461] Registering TS with master...
00:31:23.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.289578 18735 heartbeater.cc:344] Connected to a master server at 127.17.228.252:35941
00:31:23.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.289631 18735 heartbeater.cc:461] Registering TS with master...
00:31:23.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.289713 18736 heartbeater.cc:507] Master 127.17.228.254:37431 requested a full tablet report, sending...
00:31:23.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.289726 18735 heartbeater.cc:507] Master 127.17.228.252:35941 requested a full tablet report, sending...
00:31:23.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.289860 18737 heartbeater.cc:344] Connected to a master server at 127.17.228.253:33381
00:31:23.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.289892 18737 heartbeater.cc:461] Registering TS with master...
00:31:23.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.289963 18737 heartbeater.cc:507] Master 127.17.228.253:33381 requested a full tablet report, sending...
00:31:23.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.290117 18365 ts_manager.cc:194] Registered new tserver with Master: db417f5f03a84716aa7d9cd6efe37fc6 (127.17.228.193:38689)
00:31:23.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.290231 18437 ts_manager.cc:194] Registered new tserver with Master: db417f5f03a84716aa7d9cd6efe37fc6 (127.17.228.193:38689)
00:31:23.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.290704 18510 ts_manager.cc:194] Registered new tserver with Master: db417f5f03a84716aa7d9cd6efe37fc6 (127.17.228.193:38689)
00:31:23.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.291000 18365 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.17.228.193:35821
00:31:23.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.294422 18323 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_7Q1t0/build/release/bin/kudu as pid 18606
00:31:23.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.294503 18323 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-0/wal/instance
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.295408 18323 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/wal
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/data
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/logs
00:31:23.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/data/info.pb
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.194:0
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.228.194
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.194
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:23.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
00:31:23.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.368088 18742 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
00:31:23.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.368234 18742 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
00:31:23.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.368253 18742 flags.cc:432] Enabled unsafe flag: --never_fsync=true
00:31:23.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.369606 18742 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
00:31:23.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.369654 18742 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.228.194
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.371093 18742 tablet_server_runner.cc:78] Tablet server non-default flags:
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/data
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/wal
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.194:0
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/data/info.pb
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.194
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18742
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
00:31:23.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.228.194
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/logs
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 0d8247991d193c4f984e0c0bdfb0389121fdc8d9
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 00:13:03 UTC on e7f111948823
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16841
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.371251 18742 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
00:31:23.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.371416 18742 file_cache.cc:492] Constructed file cache file cache with capacity 419430
00:31:23.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.373435 18747 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
00:31:23.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.373450 18748 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
00:31:23.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.373481 18750 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
00:31:23.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.373665 18742 server_base.cc:1061] running on GCE node
00:31:23.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.373950 18742 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
00:31:23.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.374176 18742 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
00:31:23.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.375303 18742 hybrid_clock.cc:648] HybridClock initialized: now 1783470683375283 us; error 36 us; skew 500 ppm
00:31:23.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.376312 18742 webserver.cc:534] Webserver started at http://127.17.228.194:46715/ using document root <none> and password file <none>
00:31:23.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.376473 18742 fs_manager.cc:362] Metadata directory not provided
00:31:23.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.376506 18742 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
00:31:23.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.376572 18742 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
00:31:23.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.377478 18742 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/data/instance:
00:31:23.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fe2483bf3c3d4c179448533f22f0c6fa"
00:31:23.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:23 on dist-test-slave-bwrj"
00:31:23.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.377828 18742 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/wal/instance:
00:31:23.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fe2483bf3c3d4c179448533f22f0c6fa"
00:31:23.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:23 on dist-test-slave-bwrj"
00:31:23.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.379042 18742 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
00:31:23.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.379598 18756 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
00:31:23.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.379745 18742 fs_manager.cc:730] Time spent opening block manager: real 0.000s	user 0.001s	sys 0.000s
00:31:23.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.379796 18742 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/data,/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/wal
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fe2483bf3c3d4c179448533f22f0c6fa"
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:23 on dist-test-slave-bwrj"
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.379832 18742 fs_report.cc:389] FS layout report
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/wal
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/wal
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/data/data
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
00:31:23.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
00:31:23.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
00:31:23.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
00:31:23.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
00:31:23.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
00:31:23.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.398463 18742 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
00:31:23.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.398725 18742 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
00:31:23.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.398818 18742 kserver.cc:163] Server-wide thread pool size limit: 3276
00:31:23.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.398972 18742 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
00:31:23.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.399195 18742 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
00:31:23.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.399214 18742 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
00:31:23.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.399233 18742 ts_tablet_manager.cc:616] Registered 0 tablets
00:31:23.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.399245 18742 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
00:31:23.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.404280 18742 rpc_server.cc:307] RPC server started. Bound to: 127.17.228.194:44321
00:31:23.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.404354 18870 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.228.194:44321 every 8 connection(s)
00:31:23.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.404615 18742 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/data/info.pb
00:31:23.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.409241 18323 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_7Q1t0/build/release/bin/kudu as pid 18742
00:31:23.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.409322 18323 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-1/wal/instance
00:31:23.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.409456 18871 heartbeater.cc:344] Connected to a master server at 127.17.228.252:35941
00:31:23.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.409683 18871 heartbeater.cc:461] Registering TS with master...
00:31:23.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.409893 18871 heartbeater.cc:507] Master 127.17.228.252:35941 requested a full tablet report, sending...
00:31:23.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.410181 18872 heartbeater.cc:344] Connected to a master server at 127.17.228.254:37431
00:31:23.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.410241 18872 heartbeater.cc:461] Registering TS with master...
00:31:23.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.410326 18872 heartbeater.cc:507] Master 127.17.228.254:37431 requested a full tablet report, sending...
00:31:23.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.410386 18323 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:23.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_7Q1t0/build/release/bin/kudu
00:31:23.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/wal
00:31:23.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/data
00:31:23.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
00:31:23.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/logs
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/data/info.pb
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
00:31:23.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.195:0
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.228.195
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.195
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.410498 18510 ts_manager.cc:194] Registered new tserver with Master: fe2483bf3c3d4c179448533f22f0c6fa (127.17.228.194:44321)
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.410600 18365 ts_manager.cc:194] Registered new tserver with Master: fe2483bf3c3d4c179448533f22f0c6fa (127.17.228.194:44321)
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.411065 18365 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.17.228.194:44375
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.411499 18873 heartbeater.cc:344] Connected to a master server at 127.17.228.253:33381
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.411543 18873 heartbeater.cc:461] Registering TS with master...
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.411643 18873 heartbeater.cc:507] Master 127.17.228.253:33381 requested a full tablet report, sending...
00:31:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.411880 18436 ts_manager.cc:194] Registered new tserver with Master: fe2483bf3c3d4c179448533f22f0c6fa (127.17.228.194:44321)
00:31:23.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.482811 18878 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
00:31:23.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.482949 18878 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
00:31:23.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.482966 18878 flags.cc:432] Enabled unsafe flag: --never_fsync=true
00:31:23.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.484342 18878 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
00:31:23.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.484387 18878 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.228.195
00:31:23.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.485839 18878 tablet_server_runner.cc:78] Tablet server non-default flags:
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.228.212:36811
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/data
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/wal
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.228.195:0
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/data/info.pb
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.228.195
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.228.254:37431,127.17.228.253:33381,127.17.228.252:35941
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18878
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.228.195
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/logs
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
00:31:23.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
00:31:23.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
00:31:23.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
00:31:23.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
00:31:23.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 0d8247991d193c4f984e0c0bdfb0389121fdc8d9
00:31:23.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
00:31:23.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 00:13:03 UTC on e7f111948823
00:31:23.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16841
00:31:23.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.486009 18878 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
00:31:23.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.486191 18878 file_cache.cc:492] Constructed file cache file cache with capacity 419430
00:31:23.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.488222 18884 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
00:31:23.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.488265 18886 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
00:31:23.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:23.488238 18883 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
00:31:23.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.488777 18878 server_base.cc:1061] running on GCE node
00:31:23.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.488910 18878 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
00:31:23.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.489137 18878 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
00:31:23.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.490264 18878 hybrid_clock.cc:648] HybridClock initialized: now 1783470683490243 us; error 29 us; skew 500 ppm
00:31:23.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.491400 18878 webserver.cc:534] Webserver started at http://127.17.228.195:37663/ using document root <none> and password file <none>
00:31:23.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.491572 18878 fs_manager.cc:362] Metadata directory not provided
00:31:23.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.491613 18878 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
00:31:23.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.491680 18878 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
00:31:23.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.492357 18878 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/data/instance:
00:31:23.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8"
00:31:23.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:23 on dist-test-slave-bwrj"
00:31:23.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.492606 18878 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/wal/instance:
00:31:23.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8"
00:31:23.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:23 on dist-test-slave-bwrj"
00:31:23.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.493848 18878 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.002s	sys 0.000s
00:31:23.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.494617 18892 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
00:31:23.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.494797 18878 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
00:31:23.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.494859 18878 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/data,/tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/wal
00:31:23.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8"
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 00:31:23 on dist-test-slave-bwrj"
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.494910 18878 fs_report.cc:389] FS layout report
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/wal
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/wal
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/data/data
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
00:31:23.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
00:31:23.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.509589 18878 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
00:31:23.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.509783 18878 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
00:31:23.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.509855 18878 kserver.cc:163] Server-wide thread pool size limit: 3276
00:31:23.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.509985 18878 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
00:31:23.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.510200 18878 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
00:31:23.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.510224 18878 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
00:31:23.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.510242 18878 ts_tablet_manager.cc:616] Registered 0 tablets
00:31:23.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.510253 18878 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
00:31:23.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.515470 18878 rpc_server.cc:307] RPC server started. Bound to: 127.17.228.195:39695
00:31:23.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.515528 19005 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.228.195:39695 every 8 connection(s)
00:31:23.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.515838 18878 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/data/info.pb
00:31:23.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.520339 19006 heartbeater.cc:344] Connected to a master server at 127.17.228.252:35941
00:31:23.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.520428 19006 heartbeater.cc:461] Registering TS with master...
00:31:23.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.520545 19008 heartbeater.cc:344] Connected to a master server at 127.17.228.253:33381
00:31:23.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.520581 19008 heartbeater.cc:461] Registering TS with master...
00:31:23.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.520582 19006 heartbeater.cc:507] Master 127.17.228.252:35941 requested a full tablet report, sending...
00:31:23.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.520653 19008 heartbeater.cc:507] Master 127.17.228.253:33381 requested a full tablet report, sending...
00:31:23.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.520816 19007 heartbeater.cc:344] Connected to a master server at 127.17.228.254:37431
00:31:23.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.520879 19007 heartbeater.cc:461] Registering TS with master...
00:31:23.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.520965 19007 heartbeater.cc:507] Master 127.17.228.254:37431 requested a full tablet report, sending...
00:31:23.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.521057 18510 ts_manager.cc:194] Registered new tserver with Master: c8ba9d8d9d8544768f14a9aa9394e2d8 (127.17.228.195:39695)
00:31:23.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.521061 18436 ts_manager.cc:194] Registered new tserver with Master: c8ba9d8d9d8544768f14a9aa9394e2d8 (127.17.228.195:39695)
00:31:23.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.521152 18365 ts_manager.cc:194] Registered new tserver with Master: c8ba9d8d9d8544768f14a9aa9394e2d8 (127.17.228.195:39695)
00:31:23.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.521497 18365 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.17.228.195:44335
00:31:23.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.524251 18323 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_7Q1t0/build/release/bin/kudu as pid 18878
00:31:23.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.524313 18323 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_7Q1t0/test-tmp/mini-kudu-cluster4492962500567766935/ts-2/wal/instance
00:31:23.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.526114 18323 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
00:31:23.527 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
00:31:23.528 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

00:31:23.536 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.17.228.254"
      port: 37431
    }
    bound_http_address {
      host: "127.17.228.254"
      port: 46083
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.17.228.253"
      port: 33381
    }
    bound_http_address {
      host: "127.17.228.253"
      port: 40967
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.17.228.252"
      port: 35941
    }
    bound_http_address {
      host: "127.17.228.252"
      port: 38783
    }
  }
}

00:31:23.539 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

00:31:23.541 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.17.228.193"
      port: 38689
    }
    bound_http_address {
      host: "127.17.228.193"
      port: 46433
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.17.228.194"
      port: 44321
    }
    bound_http_address {
      host: "127.17.228.194"
      port: 46715
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.17.228.195"
      port: 39695
    }
    bound_http_address {
      host: "127.17.228.195"
      port: 37663
    }
  }
}

00:31:23.541 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
00:31:23.716 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
00:31:23.770 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
00:31:23.901 [DEBUG - main] (Connection.java:748) [peer master-127.17.228.253:33381(127.17.228.253:33381)] connecting to peer
00:31:23.943 [DEBUG - main] (Connection.java:748) [peer master-127.17.228.252:35941(127.17.228.252:35941)] connecting to peer
00:31:23.944 [DEBUG - main] (Connection.java:748) [peer master-127.17.228.254:37431(127.17.228.254:37431)] connecting to peer
00:31:23.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.954574 18564 catalog_manager.cc:1294] Loaded cluster ID: 76077157a722413199712745c6639ae7
00:31:23.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.954640 18564 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35: loading cluster ID for follower catalog manager: success
00:31:23.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.955596 18564 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35: acquiring CA information for follower catalog manager: success
00:31:23.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.955955 18564 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 5b12c71601f6481ba7ead23e6bb5ed35: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
00:31:23.960 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.17.228.254:37431(127.17.228.254:37431)] Successfully connected to peer
00:31:23.960 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.17.228.253:33381(127.17.228.253:33381)] Successfully connected to peer
00:31:23.960 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.17.228.252:35941(127.17.228.252:35941)] Successfully connected to peer
00:31:23.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.960067 18578 catalog_manager.cc:1294] Loaded cluster ID: 76077157a722413199712745c6639ae7
00:31:23.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.960120 18578 catalog_manager.cc:1587] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e: loading cluster ID for follower catalog manager: success
00:31:23.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.961426 18578 catalog_manager.cc:1609] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e: acquiring CA information for follower catalog manager: success
00:31:23.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:23.962244 18578 catalog_manager.cc:1637] T 00000000000000000000000000000000 P e222c6f5b48c47d2bf41838a8b72907e: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
00:31:24.037 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.17.228.253
00:31:24.036 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.17.228.252
00:31:24.042 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.17.228.254
00:31:24.238 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x4f6cd367, L:/127.0.0.1:35250 - R:/127.17.228.254:37431] using SASL/PLAIN
00:31:24.238 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xd4299565, L:/127.0.0.1:48712 - R:/127.17.228.252:35941] using SASL/PLAIN
00:31:24.238 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xc05a7c6f, L:/127.0.0.1:33008 - R:/127.17.228.253:33381] using SASL/PLAIN
00:31:24.269 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
00:31:24.270 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=401), Traces: [0ms] refreshing cache from master, [21ms] Sub RPC ConnectToMaster: sending RPC to server master-127.17.228.253:33381, [71ms] Sub RPC ConnectToMaster: sending RPC to server master-127.17.228.252:35941, [72ms] Sub RPC ConnectToMaster: sending RPC to server master-127.17.228.254:37431, [377ms] Sub RPC ConnectToMaster: received response from server master-127.17.228.253:33381: OK, [377ms] Sub RPC ConnectToMaster: received response from server master-127.17.228.252:35941: OK, [377ms] Sub RPC ConnectToMaster: received response from server master-127.17.228.254:37431: OK, deferred=null) after lookup
00:31:24.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.291635 18736 heartbeater.cc:499] Master 127.17.228.254:37431 was elected leader, sending a full tablet report...
00:31:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.316748 18365 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:35250:
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783470682118"
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
00:31:24.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
00:31:24.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
00:31:24.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:24.317925 18365 catalog_manager.cc:7076] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1783470682118 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
00:31:24.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.326808 18804 tablet_service.cc:1511] Processing CreateTablet for tablet 812089d105294b30bb53f3de83bf7411 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783470682118 [id=4754700a298c49c3b23c359667a970f9]), partition=RANGE (key) PARTITION UNBOUNDED
00:31:24.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.326902 18940 tablet_service.cc:1511] Processing CreateTablet for tablet 812089d105294b30bb53f3de83bf7411 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783470682118 [id=4754700a298c49c3b23c359667a970f9]), partition=RANGE (key) PARTITION UNBOUNDED
00:31:24.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.327090 18804 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 812089d105294b30bb53f3de83bf7411. 1 dirs total, 0 dirs full, 0 dirs failed
00:31:24.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.327097 18940 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 812089d105294b30bb53f3de83bf7411. 1 dirs total, 0 dirs full, 0 dirs failed
00:31:24.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.329492 19035 tablet_bootstrap.cc:492] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa: Bootstrap starting.
00:31:24.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.330320 19036 tablet_bootstrap.cc:492] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8: Bootstrap starting.
00:31:24.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.330520 18668 tablet_service.cc:1511] Processing CreateTablet for tablet 812089d105294b30bb53f3de83bf7411 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783470682118 [id=4754700a298c49c3b23c359667a970f9]), partition=RANGE (key) PARTITION UNBOUNDED
00:31:24.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.330798 18668 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 812089d105294b30bb53f3de83bf7411. 1 dirs total, 0 dirs full, 0 dirs failed
00:31:24.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.330972 19036 tablet_bootstrap.cc:654] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8: Neither blocks nor log segments found. Creating new log.
00:31:24.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.331238 19036 log.cc:826] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8: Log is configured to *not* fsync() on all Append() calls
00:31:24.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.331713 19035 tablet_bootstrap.cc:654] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa: Neither blocks nor log segments found. Creating new log.
00:31:24.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.331990 19035 log.cc:826] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa: Log is configured to *not* fsync() on all Append() calls
00:31:24.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.332545 19036 tablet_bootstrap.cc:492] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8: No bootstrap required, opened a new log
00:31:24.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.332608 19036 ts_tablet_manager.cc:1403] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8: Time spent bootstrapping tablet: real 0.002s	user 0.000s	sys 0.001s
00:31:24.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.333967 19036 raft_consensus.cc:359] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fe2483bf3c3d4c179448533f22f0c6fa" member_type: VOTER last_known_addr { host: "127.17.228.194" port: 44321 } } peers { permanent_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" member_type: VOTER last_known_addr { host: "127.17.228.195" port: 39695 } } peers { permanent_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" member_type: VOTER last_known_addr { host: "127.17.228.193" port: 38689 } }
00:31:24.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.334105 19036 raft_consensus.cc:385] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
00:31:24.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.334139 19036 raft_consensus.cc:740] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c8ba9d8d9d8544768f14a9aa9394e2d8, State: Initialized, Role: FOLLOWER
00:31:24.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.334867 19036 consensus_queue.cc:260] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8 [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: "fe2483bf3c3d4c179448533f22f0c6fa" member_type: VOTER last_known_addr { host: "127.17.228.194" port: 44321 } } peers { permanent_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" member_type: VOTER last_known_addr { host: "127.17.228.195" port: 39695 } } peers { permanent_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" member_type: VOTER last_known_addr { host: "127.17.228.193" port: 38689 } }
00:31:24.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.335305 19036 ts_tablet_manager.cc:1434] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8: Time spent starting tablet: real 0.003s	user 0.000s	sys 0.002s
00:31:24.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.335999 19007 heartbeater.cc:499] Master 127.17.228.254:37431 was elected leader, sending a full tablet report...
00:31:24.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.337106 19035 tablet_bootstrap.cc:492] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa: No bootstrap required, opened a new log
00:31:24.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.337335 19035 ts_tablet_manager.cc:1403] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa: Time spent bootstrapping tablet: real 0.008s	user 0.001s	sys 0.000s
00:31:24.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.337476 19039 tablet_bootstrap.cc:492] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6: Bootstrap starting.
00:31:24.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.338091 19039 tablet_bootstrap.cc:654] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6: Neither blocks nor log segments found. Creating new log.
00:31:24.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.338390 19039 log.cc:826] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6: Log is configured to *not* fsync() on all Append() calls
00:31:24.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.338973 19039 tablet_bootstrap.cc:492] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6: No bootstrap required, opened a new log
00:31:24.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.338887 19035 raft_consensus.cc:359] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fe2483bf3c3d4c179448533f22f0c6fa" member_type: VOTER last_known_addr { host: "127.17.228.194" port: 44321 } } peers { permanent_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" member_type: VOTER last_known_addr { host: "127.17.228.195" port: 39695 } } peers { permanent_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" member_type: VOTER last_known_addr { host: "127.17.228.193" port: 38689 } }
00:31:24.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.339022 19035 raft_consensus.cc:385] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
00:31:24.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.339040 19039 ts_tablet_manager.cc:1403] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6: Time spent bootstrapping tablet: real 0.002s	user 0.000s	sys 0.001s
00:31:24.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.339056 19035 raft_consensus.cc:740] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: fe2483bf3c3d4c179448533f22f0c6fa, State: Initialized, Role: FOLLOWER
00:31:24.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.339157 19035 consensus_queue.cc:260] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [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: "fe2483bf3c3d4c179448533f22f0c6fa" member_type: VOTER last_known_addr { host: "127.17.228.194" port: 44321 } } peers { permanent_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" member_type: VOTER last_known_addr { host: "127.17.228.195" port: 39695 } } peers { permanent_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" member_type: VOTER last_known_addr { host: "127.17.228.193" port: 38689 } }
00:31:24.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.339350 19035 ts_tablet_manager.cc:1434] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa: Time spent starting tablet: real 0.002s	user 0.002s	sys 0.000s
00:31:24.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.339956 18872 heartbeater.cc:499] Master 127.17.228.254:37431 was elected leader, sending a full tablet report...
00:31:24.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.340641 19039 raft_consensus.cc:359] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fe2483bf3c3d4c179448533f22f0c6fa" member_type: VOTER last_known_addr { host: "127.17.228.194" port: 44321 } } peers { permanent_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" member_type: VOTER last_known_addr { host: "127.17.228.195" port: 39695 } } peers { permanent_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" member_type: VOTER last_known_addr { host: "127.17.228.193" port: 38689 } }
00:31:24.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.340764 19039 raft_consensus.cc:385] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
00:31:24.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.340801 19039 raft_consensus.cc:740] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: db417f5f03a84716aa7d9cd6efe37fc6, State: Initialized, Role: FOLLOWER
00:31:24.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.340883 19039 consensus_queue.cc:260] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6 [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: "fe2483bf3c3d4c179448533f22f0c6fa" member_type: VOTER last_known_addr { host: "127.17.228.194" port: 44321 } } peers { permanent_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" member_type: VOTER last_known_addr { host: "127.17.228.195" port: 39695 } } peers { permanent_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" member_type: VOTER last_known_addr { host: "127.17.228.193" port: 38689 } }
00:31:24.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.341094 19039 ts_tablet_manager.cc:1434] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6: Time spent starting tablet: real 0.002s	user 0.000s	sys 0.002s
00:31:24.343 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:894) Opened table 4754700a298c49c3b23c359667a970f9
00:31:24.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.369923 19042 raft_consensus.cc:493] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
00:31:24.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.371042 19042 raft_consensus.cc:515] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fe2483bf3c3d4c179448533f22f0c6fa" member_type: VOTER last_known_addr { host: "127.17.228.194" port: 44321 } } peers { permanent_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" member_type: VOTER last_known_addr { host: "127.17.228.195" port: 39695 } } peers { permanent_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" member_type: VOTER last_known_addr { host: "127.17.228.193" port: 38689 } }
00:31:24.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.372011 19042 leader_election.cc:290] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers c8ba9d8d9d8544768f14a9aa9394e2d8 (127.17.228.195:39695), db417f5f03a84716aa7d9cd6efe37fc6 (127.17.228.193:38689)
00:31:24.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.374931 18960 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "812089d105294b30bb53f3de83bf7411" candidate_uuid: "fe2483bf3c3d4c179448533f22f0c6fa" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" is_pre_election: true
00:31:24.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.375087 18960 raft_consensus.cc:2468] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate fe2483bf3c3d4c179448533f22f0c6fa in term 0.
00:31:24.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.375280 18689 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "812089d105294b30bb53f3de83bf7411" candidate_uuid: "fe2483bf3c3d4c179448533f22f0c6fa" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" is_pre_election: true
00:31:24.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.375314 18757 leader_election.cc:304] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [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: c8ba9d8d9d8544768f14a9aa9394e2d8, fe2483bf3c3d4c179448533f22f0c6fa; no voters: 
00:31:24.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.375432 18689 raft_consensus.cc:2468] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate fe2483bf3c3d4c179448533f22f0c6fa in term 0.
00:31:24.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.375432 19042 raft_consensus.cc:2804] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [term 0 FOLLOWER]: Leader pre-election won for term 1
00:31:24.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.375479 19042 raft_consensus.cc:493] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
00:31:24.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.375500 19042 raft_consensus.cc:3060] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [term 0 FOLLOWER]: Advancing to term 1
00:31:24.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.376223 19042 raft_consensus.cc:515] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fe2483bf3c3d4c179448533f22f0c6fa" member_type: VOTER last_known_addr { host: "127.17.228.194" port: 44321 } } peers { permanent_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" member_type: VOTER last_known_addr { host: "127.17.228.195" port: 39695 } } peers { permanent_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" member_type: VOTER last_known_addr { host: "127.17.228.193" port: 38689 } }
00:31:24.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.376332 19042 leader_election.cc:290] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [CANDIDATE]: Term 1 election: Requested vote from peers c8ba9d8d9d8544768f14a9aa9394e2d8 (127.17.228.195:39695), db417f5f03a84716aa7d9cd6efe37fc6 (127.17.228.193:38689)
00:31:24.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.376531 18960 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "812089d105294b30bb53f3de83bf7411" candidate_uuid: "fe2483bf3c3d4c179448533f22f0c6fa" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8"
00:31:24.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.376598 18960 raft_consensus.cc:3060] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8 [term 0 FOLLOWER]: Advancing to term 1
00:31:24.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.376617 18689 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "812089d105294b30bb53f3de83bf7411" candidate_uuid: "fe2483bf3c3d4c179448533f22f0c6fa" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "db417f5f03a84716aa7d9cd6efe37fc6"
00:31:24.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.376690 18689 raft_consensus.cc:3060] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6 [term 0 FOLLOWER]: Advancing to term 1
00:31:24.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.377101 18960 raft_consensus.cc:2468] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate fe2483bf3c3d4c179448533f22f0c6fa in term 1.
00:31:24.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.377286 18757 leader_election.cc:304] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [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: c8ba9d8d9d8544768f14a9aa9394e2d8, fe2483bf3c3d4c179448533f22f0c6fa; no voters: 
00:31:24.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.377372 19042 raft_consensus.cc:2804] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [term 1 FOLLOWER]: Leader election won for term 1
00:31:24.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.377393 18689 raft_consensus.cc:2468] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate fe2483bf3c3d4c179448533f22f0c6fa in term 1.
00:31:24.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.377485 19042 raft_consensus.cc:697] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [term 1 LEADER]: Becoming Leader. State: Replica: fe2483bf3c3d4c179448533f22f0c6fa, State: Running, Role: LEADER
00:31:24.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.377563 19042 consensus_queue.cc:237] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [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: "fe2483bf3c3d4c179448533f22f0c6fa" member_type: VOTER last_known_addr { host: "127.17.228.194" port: 44321 } } peers { permanent_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" member_type: VOTER last_known_addr { host: "127.17.228.195" port: 39695 } } peers { permanent_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" member_type: VOTER last_known_addr { host: "127.17.228.193" port: 38689 } }
00:31:24.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.378360 18365 catalog_manager.cc:5696] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa reported cstate change: term changed from 0 to 1, leader changed from <none> to fe2483bf3c3d4c179448533f22f0c6fa (127.17.228.194). New cstate: current_term: 1 leader_uuid: "fe2483bf3c3d4c179448533f22f0c6fa" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fe2483bf3c3d4c179448533f22f0c6fa" member_type: VOTER last_known_addr { host: "127.17.228.194" port: 44321 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" member_type: VOTER last_known_addr { host: "127.17.228.195" port: 39695 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" member_type: VOTER last_known_addr { host: "127.17.228.193" port: 38689 } health_report { overall_health: UNKNOWN } } }
00:31:24.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 00:31:24.405675 18874 tablet.cc:2406] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa: Can't schedule compaction. Clean time has not been advanced past its initial value.
00:31:24.417 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet 812089d105294b30bb53f3de83bf7411 for table 'org.apache.kudu.client.TestHybridTime-1783470682118' with partition [<start>, <end>)
00:31:24.424 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=812089d105294b30bb53f3de83bf7411@[c8ba9d8d9d8544768f14a9aa9394e2d8(127.17.228.195:39695),db417f5f03a84716aa7d9cd6efe37fc6(127.17.228.193:38689),fe2483bf3c3d4c179448533f22f0c6fa(127.17.228.194:44321)[L]]}]
00:31:24.425 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=15), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.17.228.254:37431, [6ms] Sub RPC GetTableLocations: received response from server master-127.17.228.254:37431: OK, deferred=null) after lookup
00:31:24.435 [DEBUG - kudu-nio-2] (Connection.java:748) [peer fe2483bf3c3d4c179448533f22f0c6fa(127.17.228.194:44321)] connecting to peer
00:31:24.438 [DEBUG - kudu-nio-3] (Connection.java:757) [peer fe2483bf3c3d4c179448533f22f0c6fa(127.17.228.194:44321)] Successfully connected to peer
00:31:24.498 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x283b9d8e, L:/127.0.0.1:60010 - R:/127.17.228.194:44321] using TOKEN/null
00:31:24.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.501431 18689 raft_consensus.cc:1275] T 812089d105294b30bb53f3de83bf7411 P db417f5f03a84716aa7d9cd6efe37fc6 [term 1 FOLLOWER]: Refusing update from remote peer fe2483bf3c3d4c179448533f22f0c6fa: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
00:31:24.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.501724 18960 raft_consensus.cc:1275] T 812089d105294b30bb53f3de83bf7411 P c8ba9d8d9d8544768f14a9aa9394e2d8 [term 1 FOLLOWER]: Refusing update from remote peer fe2483bf3c3d4c179448533f22f0c6fa: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
00:31:24.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.502014 19042 consensus_queue.cc:1048] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [LEADER]: Connected to new peer: Peer: permanent_uuid: "db417f5f03a84716aa7d9cd6efe37fc6" member_type: VOTER last_known_addr { host: "127.17.228.193" port: 38689 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
00:31:24.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.502207 19046 consensus_queue.cc:1048] T 812089d105294b30bb53f3de83bf7411 P fe2483bf3c3d4c179448533f22f0c6fa [LEADER]: Connected to new peer: Peer: permanent_uuid: "c8ba9d8d9d8544768f14a9aa9394e2d8" member_type: VOTER last_known_addr { host: "127.17.228.195" port: 39695 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
00:31:24.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.506610 19051 mvcc.cc:204] Tried to move back new op lower bound from 7305095923715334144 to 7305095923211132928. Current Snapshot: MvccSnapshot[applied={T|T < 7305095923715334144}]
00:31:24.537 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
00:31:24.543 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
00:31:24.547 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
00:31:24.551 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@266103419(state=PENDING, result=null, callback=<none>, errback=<none>)}
00:31:24.557 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
00:31:24.558 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@890151577(state=PENDING, result=null, callback=<none>, errback=<none>)}
00:31:24.561 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
00:31:24.561 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1698094246(state=PENDING, result=null, callback=<none>, errback=<none>)}
00:31:24.565 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
00:31:24.604 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783470682118, tablet=812089d105294b30bb53f3de83bf7411, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
00:31:24.609 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305095944195334145) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783470682118, tablet=812089d105294b30bb53f3de83bf7411, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
00:31:24.612 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305095944195334149) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783470682118, tablet=812089d105294b30bb53f3de83bf7411, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
00:31:24.615 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305095944195334153) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783470682118, tablet=812089d105294b30bb53f3de83bf7411, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
00:31:24.617 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305095944195334157) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783470682118, tablet=812089d105294b30bb53f3de83bf7411, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
00:31:24.619 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305095944195334161) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783470682118, tablet=812089d105294b30bb53f3de83bf7411, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
00:31:24.622 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305095944195334165) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783470682118, tablet=812089d105294b30bb53f3de83bf7411, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
00:31:24.624 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305095944195334166) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783470682118, tablet=812089d105294b30bb53f3de83bf7411, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
00:31:24.627 [DEBUG - main] (Connection.java:575) [peer master-127.17.228.253:33381(127.17.228.253:33381)] disconnecting while in state READY
00:31:24.637 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.17.228.253:33381(127.17.228.253:33381)] handling channelInactive
00:31:24.638 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.17.228.253:33381(127.17.228.253:33381)] cleaning up while in state READY due to: connection closed
00:31:24.647 [DEBUG - main] (Connection.java:575) [peer fe2483bf3c3d4c179448533f22f0c6fa(127.17.228.194:44321)] disconnecting while in state READY
00:31:24.648 [DEBUG - kudu-nio-3] (Connection.java:239) [peer fe2483bf3c3d4c179448533f22f0c6fa(127.17.228.194:44321)] handling channelInactive
00:31:24.648 [DEBUG - main] (Connection.java:575) [peer master-127.17.228.252:35941(127.17.228.252:35941)] disconnecting while in state READY
00:31:24.648 [DEBUG - main] (Connection.java:575) [peer master-127.17.228.254:37431(127.17.228.254:37431)] disconnecting while in state READY
00:31:24.649 [DEBUG - kudu-nio-3] (Connection.java:709) [peer fe2483bf3c3d4c179448533f22f0c6fa(127.17.228.194:44321)] cleaning up while in state READY due to: connection closed
00:31:24.649 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.17.228.252:35941(127.17.228.252:35941)] handling channelInactive
00:31:24.649 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.17.228.252:35941(127.17.228.252:35941)] cleaning up while in state READY due to: connection closed
00:31:24.651 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2704) Releasing all remaining resources
00:31:24.667 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.17.228.254:37431(127.17.228.254:37431)] handling channelInactive
00:31:24.667 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.17.228.254:37431(127.17.228.254:37431)] cleaning up while in state READY due to: connection closed
00:31:24.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.667975 18323 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_7Q1t0/build/release/bin/kudu with pid 18606
00:31:24.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.675053 18323 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_7Q1t0/build/release/bin/kudu with pid 18742
00:31:24.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.680826 18323 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_7Q1t0/build/release/bin/kudu with pid 18878
00:31:24.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.686333 18323 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_7Q1t0/build/release/bin/kudu with pid 18334
00:31:24.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.693773 18323 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_7Q1t0/build/release/bin/kudu with pid 18403
00:31:24.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 00:31:24.699050 18323 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_7Q1t0/build/release/bin/kudu with pid 18477
00:31:24.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T00:31:24Z chronyd exiting

Time: 2.541

OK (1 test)

