JUnit version 4.13.2
.18:29:55.391 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783535395382
18:29:55.423 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
18:29:55.458 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
18:29:55.468 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskgZe7OK/test-tmp
18:29:55.498 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
18:29:55.501 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskgZe7OK/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
18:29:55.703 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

18:29:55.922 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:29:55.924 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

18:29:55.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:55.927620 14269 mini_oidc.cc:150] Starting JWKS server
18:29:55.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:55.931114 14269 webserver.cc:534] Webserver started at http://127.0.0.1:36759/ using document root <none> and password file <none>
18:29:55.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:55.931576 14269 mini_oidc.cc:186] Starting OIDC Discovery server
18:29:55.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:55.933816 14269 webserver.cc:534] Webserver started at http://127.0.0.1:41543/ using document root <none> and password file <none>
18:29:55.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:29:55Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
18:29:55.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:29:55Z Disabled control of system clock
18:29:55.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:55.996834 14269 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:29:55.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:29:55.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/wal
18:29:55.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/data
18:29:55.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:29:55.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:29:56.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:29:56.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:29:56.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:29:56.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:29:56.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/logs
18:29:56.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/data/info.pb
18:29:56.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:29:56.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:29:56.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:29:56.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:29:56.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:29:56.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:29:56.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:29:56.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:29:56.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:29:56.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:29:56.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:29:56.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:29:56.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.126:37421
18:29:56.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.126
18:29:56.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:29:56.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:29:56.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:29:56.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:29:56.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:29:56.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:29:56.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:29:56.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:29:56.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36759/jwks.json with env {}
18:29:56.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.305384 14281 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:29:56.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.305987 14281 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:29:56.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.306529 14281 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:29:56.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.338871 14281 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:29:56.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.339162 14281 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:29:56.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.339358 14281 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:29:56.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.339547 14281 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:29:56.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.339771 14281 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:29:56.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.339999 14281 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36759/jwks.json
18:29:56.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.376077 14281 master_runner.cc:387] Master server non-default flags:
18:29:56.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:29:56.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:29:56.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:29:56.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:29:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/data
18:29:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/wal
18:29:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:29:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:29:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:29:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:29:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:29:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.126:37421
18:29:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:29:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:29:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:29:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36759/jwks.json
18:29:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:29:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:29:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/data/info.pb
18:29:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.126
18:29:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:29:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:29:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:29:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:29:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:29:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:29:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/logs
18:29:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:29:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:29:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:29:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:29:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:29:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:29:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:29:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:29:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:29:56.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:29:56.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.377795 14281 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:29:56.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.379911 14281 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:29:56.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.391729 14287 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
18:29:57.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.394266 14288 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
18:29:57.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.396868 14290 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
18:29:57.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:57.585284 14289 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
18:29:57.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.585377 14281 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
18:29:57.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.589836 14281 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:29:57.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.593035 14281 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:29:57.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.594468 14281 hybrid_clock.cc:648] HybridClock initialized: now 1783535397594381 us; error 104 us; skew 500 ppm
18:29:57.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.595290 14281 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:29:57.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.602161 14281 webserver.cc:534] Webserver started at http://127.13.239.126:35927/ using document root <none> and password file <none>
18:29:57.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.603156 14281 fs_manager.cc:362] Metadata directory not provided
18:29:57.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.603340 14281 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:29:57.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.603826 14281 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:29:57.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.608237 14281 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/data/instance:
18:29:57.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "738cee6da60c435aa785aabd60b2bac4"
18:29:57.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:57 on dist-test-slave-fqtv"
18:29:57.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.609422 14281 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/wal/instance:
18:29:57.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "738cee6da60c435aa785aabd60b2bac4"
18:29:57.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:57 on dist-test-slave-fqtv"
18:29:57.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.622262 14281 fs_manager.cc:696] Time spent creating directory manager: real 0.012s	user 0.005s	sys 0.004s
18:29:57.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.628683 14297 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:29:57.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.629997 14281 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.001s
18:29:57.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.630299 14281 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/data,/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/wal
18:29:57.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "738cee6da60c435aa785aabd60b2bac4"
18:29:57.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:57 on dist-test-slave-fqtv"
18:29:57.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.630606 14281 fs_report.cc:389] FS layout report
18:29:57.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:29:57.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/wal
18:29:57.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/wal
18:29:57.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/data/data
18:29:57.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:29:57.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:29:57.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:29:57.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:29:57.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:29:57.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:29:57.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:29:57.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:29:57.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:29:57.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:29:57.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:29:57.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.678921 14281 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:29:57.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.680550 14281 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
18:29:57.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.681072 14281 kserver.cc:163] Server-wide thread pool size limit: 3276
18:29:57.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.753732 14281 rpc_server.cc:307] RPC server started. Bound to: 127.13.239.126:37421
18:29:57.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.753822 14354 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.239.126:37421 every 8 connection(s)
18:29:57.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.756460 14281 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/data/info.pb
18:29:57.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.763036 14355 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:29:57.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.767268 14269 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu as pid 14281
18:29:57.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.767788 14269 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-0/wal/instance
18:29:57.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.773269 14269 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:29:57.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:29:57.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/wal
18:29:57.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/data
18:29:57.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:29:57.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:29:57.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:29:57.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:29:57.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:29:57.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:29:57.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/logs
18:29:57.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/data/info.pb
18:29:57.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:29:57.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:29:57.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:29:57.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:29:57.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:29:57.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:29:57.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:29:57.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:29:57.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:29:57.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:29:57.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:29:57.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:29:57.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.125:42467
18:29:57.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.125
18:29:57.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:29:57.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:29:57.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:29:57.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:29:57.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:29:57.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:29:57.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:29:57.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:29:57.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36759/jwks.json with env {}
18:29:57.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.782080 14355 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } has no permanent_uuid. Determining permanent_uuid...
18:29:57.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.814646 14355 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } has no permanent_uuid. Determining permanent_uuid...
18:29:57.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:57.817147 14299 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.239.125:42467: connect: Connection refused (error 111)
18:29:57.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:57.821610 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.125:42467: Network error: Client connection negotiation failed: client connection to 127.13.239.125:42467: connect: Connection refused (error 111)
18:29:57.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.871214 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } attempt: 1
18:29:57.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:57.876919 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.125:42467: Network error: Client connection negotiation failed: client connection to 127.13.239.125:42467: connect: Connection refused (error 111)
18:29:57.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.945405 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } attempt: 2
18:29:57.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:57.949944 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.125:42467: Network error: Client connection negotiation failed: client connection to 127.13.239.125:42467: connect: Connection refused (error 111)
18:29:58.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.041374 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } attempt: 3
18:29:58.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.046093 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.125:42467: Network error: Client connection negotiation failed: client connection to 127.13.239.125:42467: connect: Connection refused (error 111)
18:29:58.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.100452 14357 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:29:58.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.101058 14357 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:29:58.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.101542 14357 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:29:58.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.144564 14357 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:29:58.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.144869 14357 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:29:58.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.145068 14357 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:29:58.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.145262 14357 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:29:58.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.145460 14357 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:29:58.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.145604 14357 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36759/jwks.json
18:29:58.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.182015 14357 master_runner.cc:387] Master server non-default flags:
18:29:58.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:29:58.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:29:58.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:29:58.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:29:58.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/data
18:29:58.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/wal
18:29:58.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:29:58.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:29:58.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:29:58.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:29:58.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:29:58.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.125:42467
18:29:58.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:29:58.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:29:58.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:29:58.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36759/jwks.json
18:29:58.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:29:58.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:29:58.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/data/info.pb
18:29:58.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.125
18:29:58.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:29:58.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:29:58.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:29:58.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:29:58.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:29:58.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:29:58.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/logs
18:29:58.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:29:58.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:29:58.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:29:58.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:29:58.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:29:58.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:29:58.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:29:58.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:29:58.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:29:58.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:29:58.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.183863 14357 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:29:58.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.186322 14357 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:29:58.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.189498 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } attempt: 4
18:29:58.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.194247 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.125:42467: Network error: Client connection negotiation failed: client connection to 127.13.239.125:42467: connect: Connection refused (error 111)
18:29:58.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.199725 14366 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
18:29:58.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.493690 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } attempt: 5
18:29:58.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.498508 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.125:42467: Network error: Client connection negotiation failed: client connection to 127.13.239.125:42467: connect: Connection refused (error 111)
18:29:59.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.046149 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } attempt: 6
18:29:59.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.055241 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.125:42467: Network error: Client connection negotiation failed: client connection to 127.13.239.125:42467: connect: Connection refused (error 111)
18:29:59.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.204798 14357 server_base.cc:1061] running on GCE node
18:29:59.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.206723 14369 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
18:29:59.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.203011 14367 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
18:29:59.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.434271 14357 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:29:59.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.436988 14357 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:29:59.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.438371 14357 hybrid_clock.cc:648] HybridClock initialized: now 1783535399438342 us; error 37 us; skew 500 ppm
18:29:59.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.439333 14357 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:29:59.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.445331 14357 webserver.cc:534] Webserver started at http://127.13.239.125:43243/ using document root <none> and password file <none>
18:29:59.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.446444 14357 fs_manager.cc:362] Metadata directory not provided
18:29:59.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.446693 14357 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:29:59.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.447314 14357 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:29:59.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.451645 14357 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/data/instance:
18:29:59.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aab2d84e91b343acadbd5e83014296e7"
18:29:59.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:59 on dist-test-slave-fqtv"
18:29:59.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.452961 14357 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/wal/instance:
18:29:59.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aab2d84e91b343acadbd5e83014296e7"
18:29:59.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:59 on dist-test-slave-fqtv"
18:29:59.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.460304 14357 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.006s	sys 0.000s
18:29:59.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.466328 14378 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:29:59.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.467573 14357 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.004s	sys 0.000s
18:29:59.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.467947 14357 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/data,/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/wal
18:29:59.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aab2d84e91b343acadbd5e83014296e7"
18:29:59.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:59 on dist-test-slave-fqtv"
18:29:59.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.468358 14357 fs_report.cc:389] FS layout report
18:29:59.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:29:59.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/wal
18:29:59.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/wal
18:29:59.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/data/data
18:29:59.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:29:59.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:29:59.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:29:59.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:29:59.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:29:59.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:29:59.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:29:59.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:29:59.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:29:59.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:29:59.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:29:59.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.535899 14357 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:29:59.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.537686 14357 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
18:29:59.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.538228 14357 kserver.cc:163] Server-wide thread pool size limit: 3276
18:29:59.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.612788 14357 rpc_server.cc:307] RPC server started. Bound to: 127.13.239.125:42467
18:29:59.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.612851 14429 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.239.125:42467 every 8 connection(s)
18:29:59.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.615818 14357 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/data/info.pb
18:29:59.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.621775 14430 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:29:59.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.625260 14269 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu as pid 14357
18:29:59.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.625744 14269 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-1/wal/instance
18:29:59.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.627821 14269 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:29:59.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:29:59.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/wal
18:29:59.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/data
18:29:59.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:29:59.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:29:59.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:29:59.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:29:59.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:29:59.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:29:59.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/logs
18:29:59.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/data/info.pb
18:29:59.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:29:59.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:29:59.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:29:59.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:29:59.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:29:59.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:29:59.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:29:59.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:29:59.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:29:59.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:29:59.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:29:59.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:29:59.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.124:33823
18:29:59.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.124
18:29:59.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:29:59.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:29:59.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:29:59.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:29:59.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:29:59.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:29:59.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:29:59.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:29:59.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36759/jwks.json with env {}
18:29:59.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.637575 14430 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } has no permanent_uuid. Determining permanent_uuid...
18:29:59.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.665112 14430 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } has no permanent_uuid. Determining permanent_uuid...
18:29:59.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.680835 14430 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } has no permanent_uuid. Determining permanent_uuid...
18:29:59.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.683717 14382 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:29:59.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.688555 14430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:29:59.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.738122 14430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 1
18:29:59.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.743542 14430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:29:59.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.812052 14430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 2
18:29:59.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.816825 14430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:29:59.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.908228 14430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 3
18:29:59.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.912946 14430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:29:59.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.955134 14432 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:29:59.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.955902 14432 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:29:59.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.956614 14432 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:29:59.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.989583 14432 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:29:59.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.990026 14432 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:29:59.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.990373 14432 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:29:59.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.990751 14432 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:29:59.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.991182 14432 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:29:59.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.991458 14432 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:36759/jwks.json
18:30:00.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.028797 14432 master_runner.cc:387] Master server non-default flags:
18:30:00.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:00.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:30:00.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:00.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:30:00.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/data
18:30:00.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/wal
18:30:00.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:30:00.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:30:00.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:00.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:00.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:30:00.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.124:33823
18:30:00.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:30:00.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:30:00.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:30:00.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36759/jwks.json
18:30:00.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:00.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:00.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/data/info.pb
18:30:00.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.124
18:30:00.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:00.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:30:00.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:00.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:30:00.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:30:00.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:00.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/logs
18:30:00.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:00.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:30:00.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:30:00.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:30:00.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:30:00.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:30:00.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:30:00.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:30:00.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:30:00.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:30:00.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.030592 14432 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:30:00.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.032990 14432 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:30:00.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.044554 14442 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
18:30:00.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.056389 14430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 4
18:30:00.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.064590 14430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:30:00.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.115700 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } attempt: 7
18:30:00.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.149456 14355 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } has no permanent_uuid. Determining permanent_uuid...
18:30:00.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.176887 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:30:00.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.235442 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 1
18:30:00.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.248219 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:30:00.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.329771 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 2
18:30:00.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.338209 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:30:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.364161 14430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 5
18:30:00.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.373518 14430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:30:00.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.423745 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 3
18:30:00.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.432032 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:30:00.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.572569 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 4
18:30:00.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.581722 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:30:00.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.865314 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 5
18:30:00.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.876546 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:30:00.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.921075 14430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 6
18:30:00.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.945008 14430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:30:01.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.429157 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 6
18:30:01.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.455432 14355 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.239.124:33823: Network error: Client connection negotiation failed: client connection to 127.13.239.124:33823: connect: Connection refused (error 111)
18:30:01.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.449271 14441 debug-util.cc:398] Leaking SignalData structure 0x7b0800028020 after lost signal to thread 14432
18:30:01.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.510715 14441 kernel_stack_watchdog.cc:198] Thread 14432 stuck at /home/jenkins-slave/workspace/build_and_test@2/src/kudu/util/thread.cc:642 for 401ms:
18:30:01.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
18:30:01.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
18:30:01.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
18:30:01.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
18:30:01.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.046351 14443 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
18:30:01.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.512151 14432 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.467s	user 0.000s	sys 0.003s
18:30:01.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.512599 14432 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.467s	user 0.000s	sys 0.003s
18:30:01.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.515880 14444 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1464 milliseconds
18:30:01.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.517273 14445 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
18:30:01.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.517343 14432 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
18:30:01.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.518636 14432 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:30:01.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.521066 14432 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:30:01.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.522475 14432 hybrid_clock.cc:648] HybridClock initialized: now 1783535401522420 us; error 47 us; skew 500 ppm
18:30:01.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.523468 14432 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:30:01.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.531885 14432 webserver.cc:534] Webserver started at http://127.13.239.124:46627/ using document root <none> and password file <none>
18:30:01.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.532799 14432 fs_manager.cc:362] Metadata directory not provided
18:30:01.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.532991 14432 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:30:01.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.533388 14432 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:30:01.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.537892 14432 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/data/instance:
18:30:01.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "25c3b9db612f44beb6e99875c94dff59"
18:30:01.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:01 on dist-test-slave-fqtv"
18:30:01.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.539070 14432 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/wal/instance:
18:30:01.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "25c3b9db612f44beb6e99875c94dff59"
18:30:01.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:01 on dist-test-slave-fqtv"
18:30:01.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.546602 14432 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.008s	sys 0.000s
18:30:01.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.552392 14459 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:30:01.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.553684 14432 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.000s
18:30:01.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.553966 14432 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/data,/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/wal
18:30:01.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "25c3b9db612f44beb6e99875c94dff59"
18:30:01.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:01 on dist-test-slave-fqtv"
18:30:01.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.554263 14432 fs_report.cc:389] FS layout report
18:30:01.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:30:01.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/wal
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/wal
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/data/data
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:30:01.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:30:01.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.603346 14432 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:30:01.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.604909 14432 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
18:30:01.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.605309 14432 kserver.cc:163] Server-wide thread pool size limit: 3276
18:30:01.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.683135 14432 rpc_server.cc:307] RPC server started. Bound to: 127.13.239.124:33823
18:30:01.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.683209 14510 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.239.124:33823 every 8 connection(s)
18:30:01.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.686141 14432 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/data/info.pb
18:30:01.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.692723 14511 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:30:01.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.693333 14269 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu as pid 14432
18:30:01.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.693714 14269 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/master-2/wal/instance
18:30:01.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.706224 14511 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } has no permanent_uuid. Determining permanent_uuid...
18:30:01.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.736202 14511 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } has no permanent_uuid. Determining permanent_uuid...
18:30:01.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.746802 14511 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } has no permanent_uuid. Determining permanent_uuid...
18:30:01.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.763695 14511 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59: Bootstrap starting.
18:30:01.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.770747 14511 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59: Neither blocks nor log segments found. Creating new log.
18:30:01.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.772445 14511 log.cc:826] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59: Log is configured to *not* fsync() on all Append() calls
18:30:01.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.777534 14511 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59: No bootstrap required, opened a new log
18:30:01.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.795800 14511 raft_consensus.cc:359] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } }
18:30:01.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.796427 14511 raft_consensus.cc:385] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:30:01.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.796656 14511 raft_consensus.cc:740] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 25c3b9db612f44beb6e99875c94dff59, State: Initialized, Role: FOLLOWER
18:30:01.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.797410 14511 consensus_queue.cc:260] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [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: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } }
18:30:01.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.800447 14520 sys_catalog.cc:455] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [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: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } } }
18:30:01.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.801184 14520 sys_catalog.cc:458] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [sys.catalog]: This master's current role is: FOLLOWER
18:30:01.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.802038 14511 sys_catalog.cc:565] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [sys.catalog]: configured and running, proceeding with master startup.
18:30:01.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.826040 14531 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:30:01.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.826895 14531 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:30:01.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.822443 14432 master_runner.cc:187] Error getting master registration for 127.13.239.126:37421: OK, instance_id { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" instance_seqno: 1783535397733693 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:30:01.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.845156 14432 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:30:01.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.860464 14465 tablet.cc:2406] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:30:02.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.005650 14430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 7
18:30:02.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.014115 14520 raft_consensus.cc:493] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:30:02.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.014735 14520 raft_consensus.cc:515] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } }
18:30:02.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.017736 14520 leader_election.cc:290] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 738cee6da60c435aa785aabd60b2bac4 (127.13.239.126:37421), aab2d84e91b343acadbd5e83014296e7 (127.13.239.125:42467)
18:30:02.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.029456 14430 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7: Bootstrap starting.
18:30:02.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.036880 14430 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7: Neither blocks nor log segments found. Creating new log.
18:30:02.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.039163 14430 log.cc:826] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7: Log is configured to *not* fsync() on all Append() calls
18:30:02.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.046798 14430 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7: No bootstrap required, opened a new log
18:30:02.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.075523 14430 raft_consensus.cc:359] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } }
18:30:02.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.076421 14430 raft_consensus.cc:385] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:30:02.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.076725 14430 raft_consensus.cc:740] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: aab2d84e91b343acadbd5e83014296e7, State: Initialized, Role: FOLLOWER
18:30:02.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.078028 14430 consensus_queue.cc:260] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [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: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } }
18:30:02.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.080847 14535 sys_catalog.cc:455] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [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: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } } }
18:30:02.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.081736 14535 sys_catalog.cc:458] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [sys.catalog]: This master's current role is: FOLLOWER
18:30:02.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.082726 14430 sys_catalog.cc:565] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [sys.catalog]: configured and running, proceeding with master startup.
18:30:02.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.082904 14405 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "25c3b9db612f44beb6e99875c94dff59" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "aab2d84e91b343acadbd5e83014296e7" is_pre_election: true
18:30:02.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.083807 14405 raft_consensus.cc:2468] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 25c3b9db612f44beb6e99875c94dff59 in term 0.
18:30:02.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.085286 14461 leader_election.cc:304] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [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: 25c3b9db612f44beb6e99875c94dff59, aab2d84e91b343acadbd5e83014296e7; no voters: 
18:30:02.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.086241 14520 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [term 0 FOLLOWER]: Leader pre-election won for term 1
18:30:02.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.086675 14520 raft_consensus.cc:493] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:30:02.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.087073 14520 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [term 0 FOLLOWER]: Advancing to term 1
18:30:02.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.098321 14520 raft_consensus.cc:515] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } }
18:30:02.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.101311 14520 leader_election.cc:290] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [CANDIDATE]: Term 1 election: Requested vote from peers 738cee6da60c435aa785aabd60b2bac4 (127.13.239.126:37421), aab2d84e91b343acadbd5e83014296e7 (127.13.239.125:42467)
18:30:02.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.102129 14405 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "25c3b9db612f44beb6e99875c94dff59" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "aab2d84e91b343acadbd5e83014296e7"
18:30:02.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.102846 14405 raft_consensus.cc:3060] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [term 0 FOLLOWER]: Advancing to term 1
18:30:02.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.118953 14405 raft_consensus.cc:2468] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 25c3b9db612f44beb6e99875c94dff59 in term 1.
18:30:02.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.120910 14461 leader_election.cc:304] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [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: 25c3b9db612f44beb6e99875c94dff59, aab2d84e91b343acadbd5e83014296e7; no voters: 
18:30:02.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.121848 14520 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [term 1 FOLLOWER]: Leader election won for term 1
18:30:02.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.130972 14520 raft_consensus.cc:697] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [term 1 LEADER]: Becoming Leader. State: Replica: 25c3b9db612f44beb6e99875c94dff59, State: Running, Role: LEADER
18:30:02.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.133000 14520 consensus_queue.cc:237] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [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: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } }
18:30:02.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:02.156256 14548 catalog_manager.cc:1593] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:30:02.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:02.157192 14548 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:30:02.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.158248 14544 sys_catalog.cc:455] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 25c3b9db612f44beb6e99875c94dff59. Latest consensus state: current_term: 1 leader_uuid: "25c3b9db612f44beb6e99875c94dff59" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } } }
18:30:02.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.159058 14544 sys_catalog.cc:458] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [sys.catalog]: This master's current role is: LEADER
18:30:02.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.162778 14550 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
18:30:02.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.170506 14550 catalog_manager.cc:1519] Initializing Kudu cluster ID...
18:30:02.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.194777 14405 raft_consensus.cc:1275] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [term 1 FOLLOWER]: Refusing update from remote peer 25c3b9db612f44beb6e99875c94dff59: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:30:02.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.197212 14544 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [LEADER]: Connected to new peer: Peer: permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:30:02.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.151379 14357 master_runner.cc:187] Error getting master registration for 127.13.239.126:37421: OK, instance_id { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" instance_seqno: 1783535397733693 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:30:02.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.215857 14357 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:30:02.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.249473 14535 sys_catalog.cc:455] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 25c3b9db612f44beb6e99875c94dff59. Latest consensus state: current_term: 1 leader_uuid: "25c3b9db612f44beb6e99875c94dff59" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } } }
18:30:02.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.250890 14535 sys_catalog.cc:458] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [sys.catalog]: This master's current role is: FOLLOWER
18:30:02.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.282740 14544 sys_catalog.cc:455] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "25c3b9db612f44beb6e99875c94dff59" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } } }
18:30:02.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.283569 14544 sys_catalog.cc:458] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [sys.catalog]: This master's current role is: LEADER
18:30:02.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.301306 14535 sys_catalog.cc:455] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "25c3b9db612f44beb6e99875c94dff59" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } } }
18:30:02.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.302073 14535 sys_catalog.cc:458] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7 [sys.catalog]: This master's current role is: FOLLOWER
18:30:02.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.306078 14550 catalog_manager.cc:1382] Generated new cluster ID: ea072ba1ff534cdea2fe746cf3af71ce
18:30:02.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.306391 14550 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
18:30:02.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.362069 14550 catalog_manager.cc:1405] Generated new certificate authority record
18:30:02.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.370491 14550 catalog_manager.cc:1539] Loading token signing keys...
18:30:02.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.410881 14550 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59: Generated new TSK 0
18:30:02.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.412654 14550 catalog_manager.cc:1549] Initializing in-progress tserver states...
18:30:02.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.448192 14269 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:30:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:30:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/wal
18:30:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/data
18:30:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:30:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:30:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:30:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/logs
18:30:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/data/info.pb
18:30:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:30:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:30:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:30:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:30:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:30:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:30:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.65:0
18:30:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.239.65
18:30:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.65
18:30:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:30:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:30:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:30:02.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.488869 14355 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } attempt: 7
18:30:02.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.524675 14355 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4: Bootstrap starting.
18:30:02.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.552865 14355 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4: Neither blocks nor log segments found. Creating new log.
18:30:02.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.564162 14355 log.cc:826] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4: Log is configured to *not* fsync() on all Append() calls
18:30:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.589339 14355 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4: No bootstrap required, opened a new log
18:30:02.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.645970 14355 raft_consensus.cc:359] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } }
18:30:02.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.646843 14355 raft_consensus.cc:385] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:30:02.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.647132 14355 raft_consensus.cc:740] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 738cee6da60c435aa785aabd60b2bac4, State: Initialized, Role: FOLLOWER
18:30:02.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.649654 14355 consensus_queue.cc:260] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [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: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } }
18:30:02.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.660058 14355 sys_catalog.cc:565] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [sys.catalog]: configured and running, proceeding with master startup.
18:30:02.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.660398 14325 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "25c3b9db612f44beb6e99875c94dff59" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "738cee6da60c435aa785aabd60b2bac4" is_pre_election: true
18:30:02.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.661967 14324 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "25c3b9db612f44beb6e99875c94dff59" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "738cee6da60c435aa785aabd60b2bac4"
18:30:02.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.662210 14325 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 25c3b9db612f44beb6e99875c94dff59 in term 0.
18:30:02.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.670660 14323 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [term 0 FOLLOWER]: Advancing to term 1
18:30:02.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:02.691568 14303 tablet.cc:2406] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:30:02.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.697495 14323 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [term 1 FOLLOWER]: Refusing update from remote peer 25c3b9db612f44beb6e99875c94dff59: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:30:02.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.713202 14559 sys_catalog.cc:455] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } } }
18:30:02.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.715890 14559 sys_catalog.cc:458] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [sys.catalog]: This master's current role is: FOLLOWER
18:30:02.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.719653 14520 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [LEADER]: Connected to new peer: Peer: permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:30:02.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.802320 14559 sys_catalog.cc:455] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 25c3b9db612f44beb6e99875c94dff59. Latest consensus state: current_term: 1 leader_uuid: "25c3b9db612f44beb6e99875c94dff59" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } } }
18:30:02.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.803071 14559 sys_catalog.cc:458] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [sys.catalog]: This master's current role is: FOLLOWER
18:30:02.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.805073 14568 sys_catalog.cc:455] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "25c3b9db612f44beb6e99875c94dff59" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } } }
18:30:02.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.807730 14568 sys_catalog.cc:458] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4 [sys.catalog]: This master's current role is: FOLLOWER
18:30:02.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:02.829794 14575 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
18:30:03.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:03.043447 14556 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:30:03.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:03.044034 14556 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:30:03.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:03.044656 14556 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:30:03.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:03.079074 14556 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:30:03.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:03.080138 14556 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.239.65
18:30:03.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.119066 14556 tablet_server_runner.cc:78] Tablet server non-default flags:
18:30:03.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:03.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:30:03.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:03.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:30:03.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/data
18:30:03.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/wal
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.65:0
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/data/info.pb
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.65
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.239.65
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/logs
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:30:03.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:30:03.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.120970 14556 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:30:03.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.123382 14556 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:30:03.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:03.137903 14581 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
18:30:03.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.165266 14548 catalog_manager.cc:1294] Loaded cluster ID: ea072ba1ff534cdea2fe746cf3af71ce
18:30:03.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.166807 14548 catalog_manager.cc:1587] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7: loading cluster ID for follower catalog manager: success
18:30:03.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.187347 14548 catalog_manager.cc:1609] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7: acquiring CA information for follower catalog manager: success
18:30:03.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.205353 14548 catalog_manager.cc:1637] T 00000000000000000000000000000000 P aab2d84e91b343acadbd5e83014296e7: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:30:03.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.295447 14520 sys_catalog.cc:455] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "25c3b9db612f44beb6e99875c94dff59" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "738cee6da60c435aa785aabd60b2bac4" member_type: VOTER last_known_addr { host: "127.13.239.126" port: 37421 } } peers { permanent_uuid: "aab2d84e91b343acadbd5e83014296e7" member_type: VOTER last_known_addr { host: "127.13.239.125" port: 42467 } } peers { permanent_uuid: "25c3b9db612f44beb6e99875c94dff59" member_type: VOTER last_known_addr { host: "127.13.239.124" port: 33823 } } }
18:30:03.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.297235 14520 sys_catalog.cc:458] T 00000000000000000000000000000000 P 25c3b9db612f44beb6e99875c94dff59 [sys.catalog]: This master's current role is: LEADER
18:30:03.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.859287 14575 catalog_manager.cc:1294] Loaded cluster ID: ea072ba1ff534cdea2fe746cf3af71ce
18:30:03.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.867120 14575 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4: loading cluster ID for follower catalog manager: success
18:30:03.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.906116 14575 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4: acquiring CA information for follower catalog manager: success
18:30:03.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.929045 14575 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 738cee6da60c435aa785aabd60b2bac4: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:30:05.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:03.149684 14582 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
18:30:05.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:04.539826 14580 debug-util.cc:398] Leaking SignalData structure 0x7b0800028000 after lost signal to thread 14556
18:30:05.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:05.213104 14556 thread.cc:641] GCE (cloud detector) Time spent creating pthread: real 2.065s	user 0.787s	sys 1.187s
18:30:05.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:05.220965 14556 thread.cc:608] GCE (cloud detector) Time spent starting thread: real 2.073s	user 0.787s	sys 1.187s
18:30:05.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:05.239593 14591 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
18:30:05.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.241632 14556 server_base.cc:1061] running on GCE node
18:30:05.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.244108 14556 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:30:05.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.251055 14556 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:30:05.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.253392 14556 hybrid_clock.cc:648] HybridClock initialized: now 1783535405253301 us; error 95 us; skew 500 ppm
18:30:05.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.254680 14556 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:30:05.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.290155 14556 webserver.cc:534] Webserver started at http://127.13.239.65:46657/ using document root <none> and password file <none>
18:30:05.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.291582 14556 fs_manager.cc:362] Metadata directory not provided
18:30:05.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.291962 14556 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:30:05.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.292577 14556 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:30:05.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.299608 14556 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/data/instance:
18:30:05.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b101f36e09c5417abb772a57f0f4f310"
18:30:05.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:05 on dist-test-slave-fqtv"
18:30:05.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.301196 14556 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/wal/instance:
18:30:05.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b101f36e09c5417abb772a57f0f4f310"
18:30:05.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:05 on dist-test-slave-fqtv"
18:30:05.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.318528 14556 fs_manager.cc:696] Time spent creating directory manager: real 0.017s	user 0.013s	sys 0.000s
18:30:05.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.332211 14596 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:30:05.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.333729 14556 fs_manager.cc:730] Time spent opening block manager: real 0.010s	user 0.005s	sys 0.005s
18:30:05.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.334169 14556 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/data,/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/wal
18:30:05.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b101f36e09c5417abb772a57f0f4f310"
18:30:05.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:05 on dist-test-slave-fqtv"
18:30:05.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.335702 14556 fs_report.cc:389] FS layout report
18:30:05.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:30:05.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/wal
18:30:05.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/wal
18:30:05.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/data/data
18:30:05.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:30:05.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:30:05.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:30:05.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:30:05.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:30:05.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:30:05.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:30:05.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:30:05.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:30:05.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:30:05.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:30:05.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.479313 14556 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:30:05.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.481462 14556 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
18:30:05.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.482044 14556 kserver.cc:163] Server-wide thread pool size limit: 3276
18:30:05.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.491986 14556 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:30:05.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.500370 14556 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:30:05.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.500680 14556 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:30:05.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.500973 14556 ts_tablet_manager.cc:616] Registered 0 tablets
18:30:05.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.501178 14556 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:30:05.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.904417 14556 rpc_server.cc:307] RPC server started. Bound to: 127.13.239.65:46757
18:30:05.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.904448 14709 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.239.65:46757 every 8 connection(s)
18:30:05.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.908210 14556 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/data/info.pb
18:30:05.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.909513 14269 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu as pid 14556
18:30:05.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.910130 14269 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-0/wal/instance
18:30:05.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.933874 14269 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:30:05.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:30:05.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/wal
18:30:05.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/data
18:30:05.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:30:05.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:30:05.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:30:05.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:05.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/logs
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/data/info.pb
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.66:0
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.239.66
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.66
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:30:05.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:05.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:05.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:30:06.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.010766 14711 heartbeater.cc:344] Connected to a master server at 127.13.239.124:33823
18:30:06.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.011437 14711 heartbeater.cc:461] Registering TS with master...
18:30:06.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.013108 14711 heartbeater.cc:507] Master 127.13.239.124:33823 requested a full tablet report, sending...
18:30:06.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.016139 14710 heartbeater.cc:344] Connected to a master server at 127.13.239.125:42467
18:30:06.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.017927 14710 heartbeater.cc:461] Registering TS with master...
18:30:06.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.019070 14710 heartbeater.cc:507] Master 127.13.239.125:42467 requested a full tablet report, sending...
18:30:06.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.023067 14395 ts_manager.cc:194] Registered new tserver with Master: b101f36e09c5417abb772a57f0f4f310 (127.13.239.65:46757)
18:30:06.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.028129 14476 ts_manager.cc:194] Registered new tserver with Master: b101f36e09c5417abb772a57f0f4f310 (127.13.239.65:46757)
18:30:06.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.031291 14476 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.239.65:32787
18:30:06.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.044377 14714 heartbeater.cc:344] Connected to a master server at 127.13.239.126:37421
18:30:06.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.044736 14714 heartbeater.cc:461] Registering TS with master...
18:30:06.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.046655 14714 heartbeater.cc:507] Master 127.13.239.126:37421 requested a full tablet report, sending...
18:30:06.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.049198 14314 ts_manager.cc:194] Registered new tserver with Master: b101f36e09c5417abb772a57f0f4f310 (127.13.239.65:46757)
18:30:06.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.245797 14426 debug-util.cc:398] Leaking SignalData structure 0x7b08000ad400 after lost signal to thread 14361
18:30:06.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.404605 14715 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:30:06.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.405287 14715 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:30:06.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.406101 14715 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:30:06.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.470170 14715 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:30:06.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.471808 14715 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.239.66
18:30:06.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.549490 14715 tablet_server_runner.cc:78] Tablet server non-default flags:
18:30:06.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:06.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:30:06.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:06.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:30:06.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/data
18:30:06.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/wal
18:30:06.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:06.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:06.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.66:0
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/data/info.pb
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.66
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.239.66
18:30:06.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/logs
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.551510 14715 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:30:06.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.553893 14715 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:30:06.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.570885 14727 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
18:30:07.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:07.039004 14711 heartbeater.cc:499] Master 127.13.239.124:33823 was elected leader, sending a full tablet report...
18:30:08.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:07.972927 14726 debug-util.cc:398] Leaking SignalData structure 0x7b0800028000 after lost signal to thread 14715
18:30:08.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.573920 14728 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
18:30:08.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:08.158820 14726 kernel_stack_watchdog.cc:198] Thread 14715 stuck at /home/jenkins-slave/workspace/build_and_test@2/src/kudu/util/thread.cc:642 for 398ms:
18:30:08.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
18:30:08.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
18:30:08.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
18:30:08.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
18:30:08.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:08.162544 14715 thread.cc:641] GCE (cloud detector) Time spent creating pthread: real 1.589s	user 0.585s	sys 0.864s
18:30:08.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:08.165297 14715 thread.cc:608] GCE (cloud detector) Time spent starting thread: real 1.593s	user 0.586s	sys 0.864s
18:30:08.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.168756 14715 server_base.cc:1061] running on GCE node
18:30:08.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:08.169688 14735 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
18:30:08.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.171030 14715 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:30:08.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.173231 14715 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:30:08.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.174649 14715 hybrid_clock.cc:648] HybridClock initialized: now 1783535408174604 us; error 42 us; skew 500 ppm
18:30:08.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.175521 14715 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:30:08.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.182034 14715 webserver.cc:534] Webserver started at http://127.13.239.66:34281/ using document root <none> and password file <none>
18:30:08.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.183027 14715 fs_manager.cc:362] Metadata directory not provided
18:30:08.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.183279 14715 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:30:08.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.183867 14715 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:30:08.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.188613 14715 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/data/instance:
18:30:08.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "524cf2e8948548259b3e90175090ac1c"
18:30:08.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:08 on dist-test-slave-fqtv"
18:30:08.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.190120 14715 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/wal/instance:
18:30:08.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "524cf2e8948548259b3e90175090ac1c"
18:30:08.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:08 on dist-test-slave-fqtv"
18:30:08.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.198287 14715 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.007s	sys 0.001s
18:30:08.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.204592 14740 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:30:08.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.205878 14715 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.001s
18:30:08.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.206254 14715 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/data,/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/wal
18:30:08.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "524cf2e8948548259b3e90175090ac1c"
18:30:08.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:08 on dist-test-slave-fqtv"
18:30:08.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.206607 14715 fs_report.cc:389] FS layout report
18:30:08.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:30:08.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/wal
18:30:08.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/wal
18:30:08.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/data/data
18:30:08.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:30:08.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:30:08.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:30:08.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:30:08.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:30:08.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:30:08.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:30:08.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:30:08.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:30:08.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:30:08.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:30:08.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.261188 14715 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:30:08.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.262841 14715 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
18:30:08.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.263245 14715 kserver.cc:163] Server-wide thread pool size limit: 3276
18:30:08.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.266412 14715 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:30:08.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.270977 14715 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:30:08.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.271173 14715 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:30:08.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.271374 14715 ts_tablet_manager.cc:616] Registered 0 tablets
18:30:08.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.271502 14715 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:30:08.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.464478 14715 rpc_server.cc:307] RPC server started. Bound to: 127.13.239.66:40015
18:30:08.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.464670 14852 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.239.66:40015 every 8 connection(s)
18:30:08.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.467859 14715 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/data/info.pb
18:30:08.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.473076 14269 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu as pid 14715
18:30:08.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.474087 14269 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-1/wal/instance
18:30:08.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.507855 14269 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:30:08.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu
18:30:08.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/wal
18:30:08.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/data
18:30:08.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:30:08.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:30:08.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:30:08.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:08.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:08.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:08.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/logs
18:30:08.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/data/info.pb
18:30:08.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:08.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.67:0
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.239.67
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.67
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:30:08.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:30:08.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:08.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:08.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:30:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.552187 14854 heartbeater.cc:344] Connected to a master server at 127.13.239.124:33823
18:30:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.552726 14854 heartbeater.cc:461] Registering TS with master...
18:30:08.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.554179 14854 heartbeater.cc:507] Master 127.13.239.124:33823 requested a full tablet report, sending...
18:30:08.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.557662 14853 heartbeater.cc:344] Connected to a master server at 127.13.239.125:42467
18:30:08.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.557756 14476 ts_manager.cc:194] Registered new tserver with Master: 524cf2e8948548259b3e90175090ac1c (127.13.239.66:40015)
18:30:08.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.558076 14853 heartbeater.cc:461] Registering TS with master...
18:30:08.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.559113 14853 heartbeater.cc:507] Master 127.13.239.125:42467 requested a full tablet report, sending...
18:30:08.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.559557 14476 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.239.66:57351
18:30:08.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.562541 14395 ts_manager.cc:194] Registered new tserver with Master: 524cf2e8948548259b3e90175090ac1c (127.13.239.66:40015)
18:30:08.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.576233 14855 heartbeater.cc:344] Connected to a master server at 127.13.239.126:37421
18:30:08.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.576586 14855 heartbeater.cc:461] Registering TS with master...
18:30:08.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.577283 14855 heartbeater.cc:507] Master 127.13.239.126:37421 requested a full tablet report, sending...
18:30:08.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.580339 14314 ts_manager.cc:194] Registered new tserver with Master: 524cf2e8948548259b3e90175090ac1c (127.13.239.66:40015)
18:30:08.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:08.910046 14860 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:30:08.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:08.910619 14860 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:30:08.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:08.911316 14860 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:30:08.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:08.944046 14860 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:30:08.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:08.945060 14860 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.239.67
18:30:08.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.983011 14860 tablet_server_runner.cc:78] Tablet server non-default flags:
18:30:08.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:08.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.239.84:41263
18:30:08.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:08.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:30:08.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/data
18:30:08.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/wal
18:30:08.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:08.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.239.67:0
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/data/info.pb
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.239.67
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.239.126:37421,127.13.239.125:42467,127.13.239.124:33823
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.239.67
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/logs
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:30:08.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:30:08.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:30:08.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:30:08.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:30:08.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:30:08.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.984814 14860 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:30:08.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.986660 14860 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:30:09.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:09.000394 14869 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
18:30:09.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.568934 14854 heartbeater.cc:499] Master 127.13.239.124:33823 was elected leader, sending a full tablet report...
18:30:10.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:10.403931 14868 debug-util.cc:398] Leaking SignalData structure 0x7b0800028000 after lost signal to thread 14860
18:30:10.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:10.451624 14868 kernel_stack_watchdog.cc:198] Thread 14860 stuck at /home/jenkins-slave/workspace/build_and_test@2/src/kudu/util/thread.cc:642 for 399ms:
18:30:10.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
18:30:10.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
18:30:10.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
18:30:10.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
18:30:10.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:09.001978 14870 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
18:30:10.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:10.453280 14860 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.451s	user 0.464s	sys 0.853s
18:30:10.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:10.453727 14860 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.452s	user 0.465s	sys 0.853s
18:30:10.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:10.455617 14872 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
18:30:10.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:10.457849 14871 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1450 milliseconds
18:30:10.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.457885 14860 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
18:30:10.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.459031 14860 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:30:10.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.461253 14860 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:30:10.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.462761 14860 hybrid_clock.cc:648] HybridClock initialized: now 1783535410462656 us; error 108 us; skew 500 ppm
18:30:10.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.463565 14860 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:30:10.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.470692 14860 webserver.cc:534] Webserver started at http://127.13.239.67:43141/ using document root <none> and password file <none>
18:30:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.471576 14860 fs_manager.cc:362] Metadata directory not provided
18:30:10.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.471771 14860 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:30:10.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.472141 14860 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:30:10.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.476974 14860 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/data/instance:
18:30:10.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b49c1e40b0cc443b8335c34a2a7b21c0"
18:30:10.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:10 on dist-test-slave-fqtv"
18:30:10.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.478098 14860 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/wal/instance:
18:30:10.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b49c1e40b0cc443b8335c34a2a7b21c0"
18:30:10.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:10 on dist-test-slave-fqtv"
18:30:10.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.485270 14860 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.005s	sys 0.001s
18:30:10.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.491004 14880 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:30:10.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.492170 14860 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.002s
18:30:10.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.492470 14860 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/data,/tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/wal
18:30:10.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b49c1e40b0cc443b8335c34a2a7b21c0"
18:30:10.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:10 on dist-test-slave-fqtv"
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.492760 14860 fs_report.cc:389] FS layout report
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/wal
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/wal
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/data/data
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:30:10.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:30:10.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.560236 14860 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:30:10.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.562196 14860 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
18:30:10.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.562640 14860 kserver.cc:163] Server-wide thread pool size limit: 3276
18:30:10.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.565490 14860 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:30:10.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.570036 14860 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:30:10.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.570233 14860 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:30:10.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.570423 14860 ts_tablet_manager.cc:616] Registered 0 tablets
18:30:10.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.570562 14860 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:30:10.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.730944 14860 rpc_server.cc:307] RPC server started. Bound to: 127.13.239.67:39397
18:30:10.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.731068 14992 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.239.67:39397 every 8 connection(s)
18:30:10.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.734476 14860 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/data/info.pb
18:30:10.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.741762 14269 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu as pid 14860
18:30:10.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.742353 14269 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgZe7OK/test-tmp/mini-kudu-cluster3573712553405422113/ts-2/wal/instance
18:30:10.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.784826 14993 heartbeater.cc:344] Connected to a master server at 127.13.239.125:42467
18:30:10.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.785532 14993 heartbeater.cc:461] Registering TS with master...
18:30:10.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.786984 14993 heartbeater.cc:507] Master 127.13.239.125:42467 requested a full tablet report, sending...
18:30:10.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.790588 14395 ts_manager.cc:194] Registered new tserver with Master: b49c1e40b0cc443b8335c34a2a7b21c0 (127.13.239.67:39397)
18:30:10.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.793550 14995 heartbeater.cc:344] Connected to a master server at 127.13.239.126:37421
18:30:10.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.794039 14995 heartbeater.cc:461] Registering TS with master...
18:30:10.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.794994 14995 heartbeater.cc:507] Master 127.13.239.126:37421 requested a full tablet report, sending...
18:30:10.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.802017 14314 ts_manager.cc:194] Registered new tserver with Master: b49c1e40b0cc443b8335c34a2a7b21c0 (127.13.239.67:39397)
18:30:10.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.803776 14994 heartbeater.cc:344] Connected to a master server at 127.13.239.124:33823
18:30:10.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.804178 14994 heartbeater.cc:461] Registering TS with master...
18:30:10.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.805116 14994 heartbeater.cc:507] Master 127.13.239.124:33823 requested a full tablet report, sending...
18:30:10.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.807358 14476 ts_manager.cc:194] Registered new tserver with Master: b49c1e40b0cc443b8335c34a2a7b21c0 (127.13.239.67:39397)
18:30:10.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.809165 14476 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.239.67:38219
18:30:10.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.825613 14269 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
18:30:10.837 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:30:10.838 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

18:30:10.847 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.239.126"
      port: 37421
    }
    bound_http_address {
      host: "127.13.239.126"
      port: 35927
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.13.239.125"
      port: 42467
    }
    bound_http_address {
      host: "127.13.239.125"
      port: 43243
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.13.239.124"
      port: 33823
    }
    bound_http_address {
      host: "127.13.239.124"
      port: 46627
    }
  }
}

18:30:10.850 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

18:30:10.852 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.239.65"
      port: 46757
    }
    bound_http_address {
      host: "127.13.239.65"
      port: 46657
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.13.239.66"
      port: 40015
    }
    bound_http_address {
      host: "127.13.239.66"
      port: 34281
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.13.239.67"
      port: 39397
    }
    bound_http_address {
      host: "127.13.239.67"
      port: 43141
    }
  }
}

18:30:10.852 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
18:30:11.032 [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)
18:30:11.092 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
18:30:11.237 [DEBUG - main] (Connection.java:748) [peer master-127.13.239.125:42467(127.13.239.125:42467)] connecting to peer
18:30:11.288 [DEBUG - main] (Connection.java:748) [peer master-127.13.239.126:37421(127.13.239.126:37421)] connecting to peer
18:30:11.289 [DEBUG - main] (Connection.java:748) [peer master-127.13.239.124:33823(127.13.239.124:33823)] connecting to peer
18:30:11.306 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.13.239.126:37421(127.13.239.126:37421)] Successfully connected to peer
18:30:11.307 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.13.239.124:33823(127.13.239.124:33823)] Successfully connected to peer
18:30:11.309 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.13.239.125:42467(127.13.239.125:42467)] Successfully connected to peer
18:30:11.395 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.239.124
18:30:11.395 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.239.125
18:30:11.395 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.239.126
18:30:11.635 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x45a4f40e, L:/127.0.0.1:41716 - R:/127.13.239.124:33823] using SASL/PLAIN
18:30:11.635 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x544bad45, L:/127.0.0.1:59618 - R:/127.13.239.125:42467] using SASL/PLAIN
18:30:11.635 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xe10a1282, L:/127.0.0.1:35292 - R:/127.13.239.126:37421] using SASL/PLAIN
18:30:11.674 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
18:30:11.675 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=474), Traces: [0ms] refreshing cache from master, [23ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.239.125:42467, [84ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.239.126:37421, [85ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.239.124:33823, [445ms] Sub RPC ConnectToMaster: received response from server master-127.13.239.125:42467: OK, [445ms] Sub RPC ConnectToMaster: received response from server master-127.13.239.126:37421: OK, [447ms] Sub RPC ConnectToMaster: received response from server master-127.13.239.124:33823: OK, deferred=null) after lookup
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.741060 14476 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:41716:
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783535395279"
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
18:30:11.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
18:30:11.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
18:30:11.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:30:11.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:30:11.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:11.744123 14476 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-1783535395279 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
18:30:11.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.812579 14994 heartbeater.cc:499] Master 127.13.239.124:33823 was elected leader, sending a full tablet report...
18:30:11.813 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:894) Opened table 72a71e9beff3493b832c430226dc9031
18:30:11.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.848704 14644 tablet_service.cc:1511] Processing CreateTablet for tablet 1c92019caafe4be996b7dd088f2758cb (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783535395279 [id=72a71e9beff3493b832c430226dc9031]), partition=RANGE (key) PARTITION UNBOUNDED
18:30:11.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.851497 14644 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 1c92019caafe4be996b7dd088f2758cb. 1 dirs total, 0 dirs full, 0 dirs failed
18:30:11.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.875850 14788 tablet_service.cc:1511] Processing CreateTablet for tablet 1c92019caafe4be996b7dd088f2758cb (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783535395279 [id=72a71e9beff3493b832c430226dc9031]), partition=RANGE (key) PARTITION UNBOUNDED
18:30:11.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.875837 14928 tablet_service.cc:1511] Processing CreateTablet for tablet 1c92019caafe4be996b7dd088f2758cb (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783535395279 [id=72a71e9beff3493b832c430226dc9031]), partition=RANGE (key) PARTITION UNBOUNDED
18:30:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.877733 14928 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 1c92019caafe4be996b7dd088f2758cb. 1 dirs total, 0 dirs full, 0 dirs failed
18:30:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.877733 14788 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 1c92019caafe4be996b7dd088f2758cb. 1 dirs total, 0 dirs full, 0 dirs failed
18:30:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.878894 15027 tablet_bootstrap.cc:492] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310: Bootstrap starting.
18:30:11.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.887331 15027 tablet_bootstrap.cc:654] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310: Neither blocks nor log segments found. Creating new log.
18:30:11.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.890686 15027 log.cc:826] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310: Log is configured to *not* fsync() on all Append() calls
18:30:11.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.896253 15027 tablet_bootstrap.cc:492] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310: No bootstrap required, opened a new log
18:30:11.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.896802 15027 ts_tablet_manager.cc:1403] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310: Time spent bootstrapping tablet: real 0.018s	user 0.010s	sys 0.004s
18:30:11.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.914987 15029 tablet_bootstrap.cc:492] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c: Bootstrap starting.
18:30:11.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.916882 15030 tablet_bootstrap.cc:492] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0: Bootstrap starting.
18:30:11.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.923872 15029 tablet_bootstrap.cc:654] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c: Neither blocks nor log segments found. Creating new log.
18:30:11.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.923868 15030 tablet_bootstrap.cc:654] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0: Neither blocks nor log segments found. Creating new log.
18:30:11.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.926244 15029 log.cc:826] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c: Log is configured to *not* fsync() on all Append() calls
18:30:11.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.928774 15030 log.cc:826] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0: Log is configured to *not* fsync() on all Append() calls
18:30:11.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.930519 15027 raft_consensus.cc:359] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } }
18:30:11.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.932042 15027 raft_consensus.cc:385] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:30:11.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.932526 15027 raft_consensus.cc:740] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b101f36e09c5417abb772a57f0f4f310, State: Initialized, Role: FOLLOWER
18:30:11.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.933997 15027 consensus_queue.cc:260] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310 [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: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } }
18:30:11.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.937944 15029 tablet_bootstrap.cc:492] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c: No bootstrap required, opened a new log
18:30:11.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.938632 15029 ts_tablet_manager.cc:1403] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c: Time spent bootstrapping tablet: real 0.024s	user 0.010s	sys 0.011s
18:30:11.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.944314 15027 ts_tablet_manager.cc:1434] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310: Time spent starting tablet: real 0.047s	user 0.035s	sys 0.012s
18:30:11.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.969331 15030 tablet_bootstrap.cc:492] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0: No bootstrap required, opened a new log
18:30:11.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.970072 15030 ts_tablet_manager.cc:1403] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0: Time spent bootstrapping tablet: real 0.054s	user 0.012s	sys 0.009s
18:30:11.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.971068 15029 raft_consensus.cc:359] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } }
18:30:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.971969 15029 raft_consensus.cc:385] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:30:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.972268 15029 raft_consensus.cc:740] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 524cf2e8948548259b3e90175090ac1c, State: Initialized, Role: FOLLOWER
18:30:11.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.973253 15029 consensus_queue.cc:260] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [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: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } }
18:30:11.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.976989 15029 ts_tablet_manager.cc:1434] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c: Time spent starting tablet: real 0.038s	user 0.035s	sys 0.000s
18:30:11.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.997901 15030 raft_consensus.cc:359] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } }
18:30:11.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.998602 15030 raft_consensus.cc:385] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:30:11.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.998896 15030 raft_consensus.cc:740] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b49c1e40b0cc443b8335c34a2a7b21c0, State: Initialized, Role: FOLLOWER
18:30:12.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:11.999850 15030 consensus_queue.cc:260] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [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: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } }
18:30:12.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.003716 15030 ts_tablet_manager.cc:1434] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0: Time spent starting tablet: real 0.033s	user 0.028s	sys 0.003s
18:30:12.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:12.043476 14861 tablet.cc:2406] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:30:12.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:12.045760 14718 tablet.cc:2406] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:30:12.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:12.053539 15000 tablet.cc:2406] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:30:12.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.280344 15035 raft_consensus.cc:493] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:30:12.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.280704 15034 raft_consensus.cc:493] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:30:12.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.281062 15035 raft_consensus.cc:515] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } }
18:30:12.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.281293 15034 raft_consensus.cc:515] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } }
18:30:12.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.284567 15034 leader_election.cc:290] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers b101f36e09c5417abb772a57f0f4f310 (127.13.239.65:46757), b49c1e40b0cc443b8335c34a2a7b21c0 (127.13.239.67:39397)
18:30:12.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.292887 15035 leader_election.cc:290] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers b101f36e09c5417abb772a57f0f4f310 (127.13.239.65:46757), 524cf2e8948548259b3e90175090ac1c (127.13.239.66:40015)
18:30:12.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.308467 14664 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "1c92019caafe4be996b7dd088f2758cb" candidate_uuid: "524cf2e8948548259b3e90175090ac1c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b101f36e09c5417abb772a57f0f4f310" is_pre_election: true
18:30:12.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.309468 14664 raft_consensus.cc:2468] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 524cf2e8948548259b3e90175090ac1c in term 0.
18:30:12.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.311585 14743 leader_election.cc:304] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [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: 524cf2e8948548259b3e90175090ac1c, b101f36e09c5417abb772a57f0f4f310; no voters: 
18:30:12.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.312494 15034 raft_consensus.cc:2804] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 0 FOLLOWER]: Leader pre-election won for term 1
18:30:12.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.312885 15034 raft_consensus.cc:493] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:30:12.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.313249 15034 raft_consensus.cc:3060] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 0 FOLLOWER]: Advancing to term 1
18:30:12.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.313851 14948 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "1c92019caafe4be996b7dd088f2758cb" candidate_uuid: "524cf2e8948548259b3e90175090ac1c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" is_pre_election: true
18:30:12.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.314675 14948 raft_consensus.cc:2468] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 524cf2e8948548259b3e90175090ac1c in term 0.
18:30:12.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.317000 14808 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "1c92019caafe4be996b7dd088f2758cb" candidate_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "524cf2e8948548259b3e90175090ac1c" is_pre_election: true
18:30:12.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.317584 14664 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "1c92019caafe4be996b7dd088f2758cb" candidate_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b101f36e09c5417abb772a57f0f4f310" is_pre_election: true
18:30:12.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.318163 14664 raft_consensus.cc:2468] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate b49c1e40b0cc443b8335c34a2a7b21c0 in term 0.
18:30:12.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.319298 14883 leader_election.cc:304] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [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: b101f36e09c5417abb772a57f0f4f310, b49c1e40b0cc443b8335c34a2a7b21c0; no voters: 
18:30:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.320165 15035 raft_consensus.cc:2804] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 0 FOLLOWER]: Leader pre-election won for term 1
18:30:12.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.320474 15035 raft_consensus.cc:493] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:30:12.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.320812 15035 raft_consensus.cc:3060] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 0 FOLLOWER]: Advancing to term 1
18:30:12.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.320473 15034 raft_consensus.cc:515] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } }
18:30:12.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.321944 14808 raft_consensus.cc:2393] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 1 FOLLOWER]: Leader pre-election vote request: Denying vote to candidate b49c1e40b0cc443b8335c34a2a7b21c0 in current term 1: Already voted for candidate 524cf2e8948548259b3e90175090ac1c in this term.
18:30:12.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.322453 15034 leader_election.cc:290] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [CANDIDATE]: Term 1 election: Requested vote from peers b101f36e09c5417abb772a57f0f4f310 (127.13.239.65:46757), b49c1e40b0cc443b8335c34a2a7b21c0 (127.13.239.67:39397)
18:30:12.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.324865 14948 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "1c92019caafe4be996b7dd088f2758cb" candidate_uuid: "524cf2e8948548259b3e90175090ac1c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0"
18:30:12.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.326113 14664 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "1c92019caafe4be996b7dd088f2758cb" candidate_uuid: "524cf2e8948548259b3e90175090ac1c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b101f36e09c5417abb772a57f0f4f310"
18:30:12.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.326661 14664 raft_consensus.cc:3060] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310 [term 0 FOLLOWER]: Advancing to term 1
18:30:12.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.327746 15035 raft_consensus.cc:515] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } }
18:30:12.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.328882 14948 raft_consensus.cc:2393] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 1 FOLLOWER]: Leader election vote request: Denying vote to candidate 524cf2e8948548259b3e90175090ac1c in current term 1: Already voted for candidate b49c1e40b0cc443b8335c34a2a7b21c0 in this term.
18:30:12.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.330914 15035 leader_election.cc:290] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [CANDIDATE]: Term 1 election: Requested vote from peers b101f36e09c5417abb772a57f0f4f310 (127.13.239.65:46757), 524cf2e8948548259b3e90175090ac1c (127.13.239.66:40015)
18:30:12.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.330825 14663 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "1c92019caafe4be996b7dd088f2758cb" candidate_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b101f36e09c5417abb772a57f0f4f310"
18:30:12.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.332834 14808 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "1c92019caafe4be996b7dd088f2758cb" candidate_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "524cf2e8948548259b3e90175090ac1c"
18:30:12.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.333686 14808 raft_consensus.cc:2393] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 1 FOLLOWER]: Leader election vote request: Denying vote to candidate b49c1e40b0cc443b8335c34a2a7b21c0 in current term 1: Already voted for candidate 524cf2e8948548259b3e90175090ac1c in this term.
18:30:12.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.334236 14664 raft_consensus.cc:2468] T 1c92019caafe4be996b7dd088f2758cb P b101f36e09c5417abb772a57f0f4f310 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 524cf2e8948548259b3e90175090ac1c in term 1.
18:30:12.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.334870 14881 leader_election.cc:304] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [CANDIDATE]: Term 1 election: Election decided. Result: candidate lost. Election summary: received 3 responses out of 3 voters: 1 yes votes; 2 no votes. yes voters: b49c1e40b0cc443b8335c34a2a7b21c0; no voters: 524cf2e8948548259b3e90175090ac1c, b101f36e09c5417abb772a57f0f4f310
18:30:12.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.335672 15035 raft_consensus.cc:2749] T 1c92019caafe4be996b7dd088f2758cb P b49c1e40b0cc443b8335c34a2a7b21c0 [term 1 FOLLOWER]: Leader election lost for term 1. Reason: could not achieve majority
18:30:12.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.335554 14743 leader_election.cc:304] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 3 responses out of 3 voters: 2 yes votes; 1 no votes. yes voters: 524cf2e8948548259b3e90175090ac1c, b101f36e09c5417abb772a57f0f4f310; no voters: b49c1e40b0cc443b8335c34a2a7b21c0
18:30:12.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.336284 15034 raft_consensus.cc:2804] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 1 FOLLOWER]: Leader election won for term 1
18:30:12.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.338604 15034 raft_consensus.cc:697] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [term 1 LEADER]: Becoming Leader. State: Replica: 524cf2e8948548259b3e90175090ac1c, State: Running, Role: LEADER
18:30:12.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.339808 15034 consensus_queue.cc:237] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [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: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } }
18:30:12.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.350018 14476 catalog_manager.cc:5696] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c reported cstate change: term changed from 0 to 1, leader changed from <none> to 524cf2e8948548259b3e90175090ac1c (127.13.239.66). New cstate: current_term: 1 leader_uuid: "524cf2e8948548259b3e90175090ac1c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "524cf2e8948548259b3e90175090ac1c" member_type: VOTER last_known_addr { host: "127.13.239.66" port: 40015 } health_report { overall_health: HEALTHY } } }
18:30:12.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.851330 15051 consensus_queue.cc:1048] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [LEADER]: Connected to new peer: Peer: permanent_uuid: "b101f36e09c5417abb772a57f0f4f310" member_type: VOTER last_known_addr { host: "127.13.239.65" port: 46757 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:30:12.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:12.878155 15051 consensus_queue.cc:1048] T 1c92019caafe4be996b7dd088f2758cb P 524cf2e8948548259b3e90175090ac1c [LEADER]: Connected to new peer: Peer: permanent_uuid: "b49c1e40b0cc443b8335c34a2a7b21c0" member_type: VOTER last_known_addr { host: "127.13.239.67" port: 39397 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:30:12.912 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet 1c92019caafe4be996b7dd088f2758cb for table 'org.apache.kudu.client.TestHybridTime-1783535395279' with partition [<start>, <end>)
18:30:12.919 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=1c92019caafe4be996b7dd088f2758cb@[524cf2e8948548259b3e90175090ac1c(127.13.239.66:40015)[L],b101f36e09c5417abb772a57f0f4f310(127.13.239.65:46757),b49c1e40b0cc443b8335c34a2a7b21c0(127.13.239.67:39397)]}]
18:30:12.920 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=20), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.13.239.124:33823, [11ms] Sub RPC GetTableLocations: received response from server master-127.13.239.124:33823: OK, deferred=null) after lookup
18:30:12.931 [DEBUG - kudu-nio-2] (Connection.java:748) [peer 524cf2e8948548259b3e90175090ac1c(127.13.239.66:40015)] connecting to peer
18:30:12.934 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 524cf2e8948548259b3e90175090ac1c(127.13.239.66:40015)] Successfully connected to peer
18:30:13.008 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x32e49be2, L:/127.0.0.1:45458 - R:/127.13.239.66:40015] using TOKEN/null
18:30:13.088 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:30:13.116 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:30:13.133 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:30:13.140 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1172437088(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:13.172 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:30:13.173 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1972149849(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:13.194 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:30:13.195 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1850051242(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:13.210 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:30:13.272 [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-1783535395279, tablet=1c92019caafe4be996b7dd088f2758cb, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:30:13.287 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305361072202690561) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783535395279, tablet=1c92019caafe4be996b7dd088f2758cb, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:30:13.298 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305361072202690565) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783535395279, tablet=1c92019caafe4be996b7dd088f2758cb, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:30:13.310 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305361072202690569) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783535395279, tablet=1c92019caafe4be996b7dd088f2758cb, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:30:13.321 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305361072202690573) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783535395279, tablet=1c92019caafe4be996b7dd088f2758cb, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:30:13.332 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305361072202690577) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783535395279, tablet=1c92019caafe4be996b7dd088f2758cb, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:30:13.342 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305361072202690581) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783535395279, tablet=1c92019caafe4be996b7dd088f2758cb, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:30:13.352 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305361072202690582) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783535395279, tablet=1c92019caafe4be996b7dd088f2758cb, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:30:13.355 [DEBUG - main] (Connection.java:575) [peer master-127.13.239.126:37421(127.13.239.126:37421)] disconnecting while in state READY
18:30:13.356 [DEBUG - main] (Connection.java:575) [peer master-127.13.239.124:33823(127.13.239.124:33823)] disconnecting while in state READY
18:30:13.357 [DEBUG - main] (Connection.java:575) [peer master-127.13.239.125:42467(127.13.239.125:42467)] disconnecting while in state READY
18:30:13.358 [DEBUG - main] (Connection.java:575) [peer 524cf2e8948548259b3e90175090ac1c(127.13.239.66:40015)] disconnecting while in state READY
18:30:13.361 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.13.239.125:42467(127.13.239.125:42467)] handling channelInactive
18:30:13.362 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.13.239.125:42467(127.13.239.125:42467)] cleaning up while in state READY due to: connection closed
18:30:13.363 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.13.239.124:33823(127.13.239.124:33823)] handling channelInactive
18:30:13.363 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.13.239.124:33823(127.13.239.124:33823)] cleaning up while in state READY due to: connection closed
18:30:13.364 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
18:30:13.364 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 524cf2e8948548259b3e90175090ac1c(127.13.239.66:40015)] handling channelInactive
18:30:13.364 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 524cf2e8948548259b3e90175090ac1c(127.13.239.66:40015)] cleaning up while in state READY due to: connection closed
18:30:13.370 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.13.239.126:37421(127.13.239.126:37421)] handling channelInactive
18:30:13.370 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.13.239.126:37421(127.13.239.126:37421)] cleaning up while in state READY due to: connection closed
18:30:13.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:13.371590 14269 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu with pid 14556
18:30:13.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:13.408162 14269 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu with pid 14715
18:30:13.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:13.440866 14269 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu with pid 14860
18:30:13.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:13.471956 14269 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu with pid 14281
18:30:13.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:13.512916 14269 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu with pid 14357
18:30:13.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:13.540294 14269 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgZe7OK/build/tsan/bin/kudu with pid 14432
18:30:14.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:30:14Z chronyd exiting

Time: 20.414

OK (1 test)

