JUnit version 4.13.2
.14:21:55.736 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1779114115726
14:21:55.771 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
14:21:55.803 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
14:21:55.810 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskoCowaL/test-tmp
14:21:55.837 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
14:21:55.839 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskoCowaL/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
14:21:56.039 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787"
  extra_master_flags: "--webserver_require_spnego=false"
  extra_master_flags: "--authn_token_validity_seconds=1"
  extra_master_flags: "--rpc_default_keepalive_time_ms=120000"
  extra_tserver_flags: "--webserver_require_spnego=false"
  extra_tserver_flags: "--rpc_default_keepalive_time_ms=120000"
  extra_tserver_flags: "--rpc_inject_invalid_authn_token_ratio=0.5"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

14:21:56.224 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:21:56.226 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

14:21:56.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:21:56.229974  7872 mini_oidc.cc:150] Starting JWKS server
14:21:56.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:21:56.233750  7872 webserver.cc:533] Webserver started at http://127.0.0.1:44623/ using document root <none> and password file <none>
14:21:56.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:21:56.234431  7872 mini_oidc.cc:186] Starting OIDC Discovery server
14:21:56.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:21:56.237217  7872 webserver.cc:533] Webserver started at http://127.0.0.1:37453/ using document root <none> and password file <none>
14:21:56.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
14:21:56.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/principal' for realm 'KRBTEST.COM',
14:21:56.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
14:21:56.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:21:56 dist-test-slave-ss1p krb5kdc[7883](info): setting up network...
14:21:56.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
14:21:56.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:21:56 dist-test-slave-ss1p krb5kdc[7883](info): set up 2 sockets
14:21:56.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:21:56 dist-test-slave-ss1p krb5kdc[7883](info): commencing operation
14:21:56.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
14:21:58.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.291239  7872 mini_kdc.cc:121] Time spent starting KDC: real 2.012s	user 0.005s	sys 0.015s
14:21:58.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
14:21:58.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:21:58.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
14:21:58.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
14:21:58.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:21:58.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
14:21:58.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
14:21:58.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:21:58.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
14:21:58.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:21:58.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal test-user with kvno 1, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/test-user.keytab.
14:21:58.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal test-user with kvno 1, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/test-user.keytab.
14:21:58.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:21:58 dist-test-slave-ss1p krb5kdc[7883](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779114118, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:21:58.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
14:21:58.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:21:58Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
14:21:58.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:21:58Z Disabled control of system clock
14:21:58.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.176.62@KRBTEST.COM; defaulting to no policy
14:21:58.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:58.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.176.62@KRBTEST.COM" created.
14:21:58.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:58.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.176.62 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:21:58.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.176.62 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:21:58.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.7.176.62@KRBTEST.COM; defaulting to no policy
14:21:58.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:58.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.7.176.62@KRBTEST.COM" created.
14:21:58.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:58.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.176.62 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:21:58.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.176.62 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:21:58.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:21:58.548492  7872 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu
14:21:58.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu
14:21:58.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/wal
14:21:58.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/data
14:21:58.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:21:58.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:21:58.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:21:58.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:58.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:58.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:58.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/logs
14:21:58.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/data/info.pb
14:21:58.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:58.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:21:58.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:21:58.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:21:58.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:21:58.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:58.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:58.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:58.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:21:58.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:21:58.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:21:58.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:21:58.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.176.62:46451
14:21:58.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.176.62
14:21:58.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:58.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab
14:21:58.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.176.62
14:21:58.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:21:58.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:21:58.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:21:58.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:21:58.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.176.20:43355
14:21:58.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:58.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:58.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:58.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:21:58.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.176.62:46451
14:21:58.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:21:58.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44623/jwks.json
14:21:58.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:21:58.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
14:21:58.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000 with env {KRB5CCNAME=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:21:58.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.856653  7899 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:21:58.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.857339  7899 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:21:58.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.858031  7899 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:21:58.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.890887  7899 flags.cc:432] Enabled experimental flag: --authn_token_validity_seconds=1
14:21:58.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.891121  7899 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:21:58.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.891435  7899 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:21:58.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.891744  7899 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:21:58.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.892066  7899 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:21:58.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.892400  7899 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:21:58.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.892647  7899 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:44623/jwks.json
14:21:58.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:21:58.931406  7899 master_runner.cc:387] Master server non-default flags:
14:21:58.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:58.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.176.20:43355
14:21:58.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:58.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:58.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/data
14:21:58.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/wal
14:21:58.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
14:21:58.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:21:58.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.176.62:46451
14:21:58.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab
14:21:58.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.176.62
14:21:58.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:58.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:58.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:21:58.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.176.62:46451
14:21:58.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:21:58.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:21:58.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:21:58.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44623/jwks.json
14:21:58.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:21:58.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:21:58.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:21:58.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:21:58.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:58.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:58.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/data/info.pb
14:21:58.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.176.62
14:21:58.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:58.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:21:58.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:58.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:21:58.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:21:58.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:58.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/logs
14:21:58.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:58.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:21:58.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:21:58.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:21:58.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:21:58.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:21:58.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:21:58.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:54 UTC on bdcb31816ec0
14:21:58.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15854
14:21:58.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:21:58.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:21:58.932667  7899 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:21:58.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:21:58.934074  7899 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:21:58.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.947513  7905 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
14:22:00.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:21:58.948777  7906 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
14:22:00.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:00.191749  7908 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
14:22:00.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:00.195585  7899 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.248s	user 0.395s	sys 0.850s
14:22:00.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:00.196007  7899 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.248s	user 0.395s	sys 0.850s
14:22:00.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:00.197958  7907 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1247 milliseconds
14:22:00.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.198028  7899 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
14:22:00.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.200420  7899 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:22:00.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.203785  7899 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:22:00.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.205720  7899 hybrid_clock.cc:648] HybridClock initialized: now 1779114120205676 us; error 40 us; skew 500 ppm
14:22:00.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.207010  7899 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:22:00.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:22:00 dist-test-slave-ss1p krb5kdc[7883](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779114120, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.176.62@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:22:00.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.216342  7899 init.cc:377] Logged in from keytab as kudu/127.7.176.62@KRBTEST.COM (short username kudu)
14:22:00.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.222991  7899 webserver.cc:533] Webserver started at http://127.7.176.62:35225/ using document root <none> and password file <none>
14:22:00.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.224364  7899 fs_manager.cc:362] Metadata directory not provided
14:22:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.224746  7899 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:22:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.225355  7899 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:22:00.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.232770  7899 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/data/instance:
14:22:00.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "87968bd9bab6479697dc4617d6953a75"
14:22:00.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:00 on dist-test-slave-ss1p"
14:22:00.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.234702  7899 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/wal/instance:
14:22:00.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "87968bd9bab6479697dc4617d6953a75"
14:22:00.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:00 on dist-test-slave-ss1p"
14:22:00.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.245724  7899 fs_manager.cc:696] Time spent creating directory manager: real 0.010s	user 0.009s	sys 0.001s
14:22:00.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.254047  7916 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:22:00.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.256330  7899 fs_manager.cc:730] Time spent opening block manager: real 0.006s	user 0.003s	sys 0.000s
14:22:00.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.257105  7899 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/data,/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/wal
14:22:00.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "87968bd9bab6479697dc4617d6953a75"
14:22:00.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:00 on dist-test-slave-ss1p"
14:22:00.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.257623  7899 fs_report.cc:389] FS layout report
14:22:00.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:22:00.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/wal
14:22:00.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/wal
14:22:00.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/data/data
14:22:00.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:22:00.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:22:00.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:22:00.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:22:00.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:22:00.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:22:00.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:22:00.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:22:00.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:22:00.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:22:00.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:22:00.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.329155  7899 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:22:00.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.338493  7899 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
14:22:00.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.338928  7899 kserver.cc:163] Server-wide thread pool size limit: 3276
14:22:00.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.411984  7899 rpc_server.cc:307] RPC server started. Bound to: 127.7.176.62:46451
14:22:00.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.412057  7967 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.176.62:46451 every 8 connection(s)
14:22:00.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.415798  7899 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/data/info.pb
14:22:00.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.416738  7872 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu as pid 7899
14:22:00.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.417279  7872 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/master-0/wal/instance
14:22:00.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.426549  7968 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:22:00.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.454528  7968 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75: Bootstrap starting.
14:22:00.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.461000  7968 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75: Neither blocks nor log segments found. Creating new log.
14:22:00.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.463178  7968 log.cc:826] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75: Log is configured to *not* fsync() on all Append() calls
14:22:00.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.468870  7968 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75: No bootstrap required, opened a new log
14:22:00.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:22:00 dist-test-slave-ss1p krb5kdc[7883](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779114118, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.7.176.62@KRBTEST.COM
14:22:00.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.488502  7968 raft_consensus.cc:359] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "87968bd9bab6479697dc4617d6953a75" member_type: VOTER last_known_addr { host: "127.7.176.62" port: 46451 } }
14:22:00.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.489257  7968 raft_consensus.cc:385] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:22:00.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.489552  7968 raft_consensus.cc:740] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 87968bd9bab6479697dc4617d6953a75, State: Initialized, Role: FOLLOWER
14:22:00.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.490551  7968 consensus_queue.cc:260] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "87968bd9bab6479697dc4617d6953a75" member_type: VOTER last_known_addr { host: "127.7.176.62" port: 46451 } }
14:22:00.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.491504  7968 raft_consensus.cc:399] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
14:22:00.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.491779  7968 raft_consensus.cc:493] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
14:22:00.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.492050  7968 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [term 0 FOLLOWER]: Advancing to term 1
14:22:00.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.496598  7968 raft_consensus.cc:515] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "87968bd9bab6479697dc4617d6953a75" member_type: VOTER last_known_addr { host: "127.7.176.62" port: 46451 } }
14:22:00.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.497288  7968 leader_election.cc:304] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: 87968bd9bab6479697dc4617d6953a75; no voters: 
14:22:00.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.498994  7968 leader_election.cc:290] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [CANDIDATE]: Term 1 election: Requested vote from peers 
14:22:00.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.499349  7973 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [term 1 FOLLOWER]: Leader election won for term 1
14:22:00.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.502403  7973 raft_consensus.cc:697] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [term 1 LEADER]: Becoming Leader. State: Replica: 87968bd9bab6479697dc4617d6953a75, State: Running, Role: LEADER
14:22:00.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.504068  7968 sys_catalog.cc:565] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [sys.catalog]: configured and running, proceeding with master startup.
14:22:00.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.503685  7973 consensus_queue.cc:237] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "87968bd9bab6479697dc4617d6953a75" member_type: VOTER last_known_addr { host: "127.7.176.62" port: 46451 } }
14:22:00.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.512943  7975 sys_catalog.cc:455] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 87968bd9bab6479697dc4617d6953a75. Latest consensus state: current_term: 1 leader_uuid: "87968bd9bab6479697dc4617d6953a75" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "87968bd9bab6479697dc4617d6953a75" member_type: VOTER last_known_addr { host: "127.7.176.62" port: 46451 } } }
14:22:00.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.513279  7974 sys_catalog.cc:455] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "87968bd9bab6479697dc4617d6953a75" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "87968bd9bab6479697dc4617d6953a75" member_type: VOTER last_known_addr { host: "127.7.176.62" port: 46451 } } }
14:22:00.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.514678  7974 sys_catalog.cc:458] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [sys.catalog]: This master's current role is: LEADER
14:22:00.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.514652  7975 sys_catalog.cc:458] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75 [sys.catalog]: This master's current role is: LEADER
14:22:00.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.518831  7981 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
14:22:00.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.529996  7981 catalog_manager.cc:1520] Initializing Kudu cluster ID...
14:22:00.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.547222  7981 catalog_manager.cc:1383] Generated new cluster ID: f50d5898e40c4cab8d24741c2a803032
14:22:00.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.547550  7981 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
14:22:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.582808  7981 catalog_manager.cc:1406] Generated new certificate authority record
14:22:00.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.584534  7981 catalog_manager.cc:1540] Loading token signing keys...
14:22:00.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.598487  7981 catalog_manager.cc:6070] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75: Generated new TSK 0
14:22:00.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.599635  7981 catalog_manager.cc:1550] Initializing in-progress tserver states...
14:22:00.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.176.1@KRBTEST.COM; defaulting to no policy
14:22:00.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:00.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.176.1@KRBTEST.COM" created.
14:22:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.176.1 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.176.1 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:00.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.7.176.1@KRBTEST.COM; defaulting to no policy
14:22:00.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:00.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.7.176.1@KRBTEST.COM" created.
14:22:00.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:00.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.176.1 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:00.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.176.1 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:00.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:00.702589  7872 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu
14:22:00.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu
14:22:00.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/wal
14:22:00.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/data
14:22:00.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:22:00.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:22:00.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:22:00.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:22:00.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:22:00.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:22:00.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/logs
14:22:00.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/data/info.pb
14:22:00.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:22:00.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:22:00.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:22:00.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:22:00.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:22:00.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:22:00.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:22:00.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:22:00.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:22:00.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:22:00.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.176.1:0
14:22:00.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.176.1
14:22:00.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.176.1
14:22:00.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:22:00.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.176.62:46451
14:22:00.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab
14:22:00.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.176.1
14:22:00.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:22:00.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:22:00.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:22:00.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:22:00.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.176.20:43355
14:22:00.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:22:00.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:22:00.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:22:00.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:22:00.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:22:00.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:22:01.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:01.024060  7996 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:22:01.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:01.024627  7996 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:22:01.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:01.024829  7996 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:22:01.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:01.025624  7996 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:22:01.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:01.058917  7996 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:22:01.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:01.059841  7996 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.176.1
14:22:01.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:01.098007  7996 tablet_server_runner.cc:78] Tablet server non-default flags:
14:22:01.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:22:01.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.176.20:43355
14:22:01.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:22:01.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:22:01.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/data
14:22:01.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/wal
14:22:01.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:22:01.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab
14:22:01.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.176.1
14:22:01.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:22:01.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:22:01.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.176.1:0
14:22:01.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:22:01.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:22:01.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:22:01.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:22:01.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:22:01.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:22:01.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:22:01.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/data/info.pb
14:22:01.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.176.1
14:22:01.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:22:01.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.176.62:46451
14:22:01.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:22:01.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:22:01.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:22:01.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:22:01.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:22:01.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.176.1
14:22:01.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/logs
14:22:01.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:22:01.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:22:01.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:22:01.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:22:01.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:22:01.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:22:01.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:22:01.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:54 UTC on bdcb31816ec0
14:22:01.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15854
14:22:01.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:22:01.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:01.099610  7996 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:22:01.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:01.101029  7996 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:22:01.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:01.116811  8002 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
14:22:02.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:02.518779  8001 debug-util.cc:398] Leaking SignalData structure 0x7b0800037380 after lost signal to thread 7996
14:22:02.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:02.704809  8001 kernel_stack_watchdog.cc:198] Thread 7996 stuck at /home/jenkins-slave/workspace/build_and_test@2/src/kudu/util/thread.cc:642 for 398ms:
14:22:02.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
14:22:02.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
14:22:02.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
14:22:02.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
14:22:02.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:02.705705  7996 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.587s	user 0.002s	sys 0.000s
14:22:02.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:02.706100  7996 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.588s	user 0.002s	sys 0.000s
14:22:02.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:01.118495  8003 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
14:22:02.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:02.708206  8005 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
14:22:02.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.715293  7996 server_base.cc:1061] running on GCE node
14:22:02.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.716755  7996 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:22:02.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.719636  7996 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:22:02.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.721086  7996 hybrid_clock.cc:648] HybridClock initialized: now 1779114122721036 us; error 44 us; skew 500 ppm
14:22:02.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.722028  7996 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:22:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:22:02 dist-test-slave-ss1p krb5kdc[7883](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779114122, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.176.1@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:22:02.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.728658  7996 init.cc:377] Logged in from keytab as kudu/127.7.176.1@KRBTEST.COM (short username kudu)
14:22:02.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.733920  7996 webserver.cc:533] Webserver started at http://127.7.176.1:34379/ using document root <none> and password file <none>
14:22:02.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.734807  7996 fs_manager.cc:362] Metadata directory not provided
14:22:02.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.734993  7996 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:22:02.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.735373  7996 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:22:02.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.739815  7996 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/data/instance:
14:22:02.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aafd1029f0a24b31beab50faf80ce92a"
14:22:02.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:02 on dist-test-slave-ss1p"
14:22:02.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.741039  7996 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/wal/instance:
14:22:02.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aafd1029f0a24b31beab50faf80ce92a"
14:22:02.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:02 on dist-test-slave-ss1p"
14:22:02.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.750125  7996 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.010s	sys 0.001s
14:22:02.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.755941  8013 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:22:02.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.757138  7996 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.000s	sys 0.006s
14:22:02.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.757513  7996 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/data,/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/wal
14:22:02.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aafd1029f0a24b31beab50faf80ce92a"
14:22:02.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:02 on dist-test-slave-ss1p"
14:22:02.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.758054  7996 fs_report.cc:389] FS layout report
14:22:02.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:22:02.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/wal
14:22:02.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/wal
14:22:02.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/data/data
14:22:02.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:22:02.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:22:02.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:22:02.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:22:02.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:22:02.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:22:02.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:22:02.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:22:02.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:22:02.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:22:02.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:22:02.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.835467  7996 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:22:02.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.841374  7996 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
14:22:02.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.841956  7996 kserver.cc:163] Server-wide thread pool size limit: 3276
14:22:02.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.844892  7996 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:22:02.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.849315  7996 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:22:02.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.849687  7996 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:22:02.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.849998  7996 ts_tablet_manager.cc:616] Registered 0 tablets
14:22:02.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.850214  7996 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:22:02.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.996604  7996 rpc_server.cc:307] RPC server started. Bound to: 127.7.176.1:46641
14:22:02.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.996694  8125 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.176.1:46641 every 8 connection(s)
14:22:03.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:02.999689  7996 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/data/info.pb
14:22:03.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:03.003542  7872 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu as pid 7996
14:22:03.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:03.004017  7872 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/wal/instance
14:22:03.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:22:03 dist-test-slave-ss1p krb5kdc[7883](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779114122, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.176.1@KRBTEST.COM for kudu/127.7.176.62@KRBTEST.COM
14:22:03.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.176.2@KRBTEST.COM; defaulting to no policy
14:22:03.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:03.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.176.2@KRBTEST.COM" created.
14:22:03.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:03.036387  8126 heartbeater.cc:344] Connected to a master server at 127.7.176.62:46451
14:22:03.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:03.036931  8126 heartbeater.cc:461] Registering TS with master...
14:22:03.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:03.038321  8126 heartbeater.cc:507] Master 127.7.176.62:46451 requested a full tablet report, sending...
14:22:03.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:03.041623  7933 ts_manager.cc:194] Registered new tserver with Master: aafd1029f0a24b31beab50faf80ce92a (127.7.176.1:46641)
14:22:03.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:03.044637  7933 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.7.176.1@KRBTEST.COM'} at 127.7.176.1:44237
14:22:03.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:03.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.176.2 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:03.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.176.2 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:03.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.7.176.2@KRBTEST.COM; defaulting to no policy
14:22:03.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:03.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.7.176.2@KRBTEST.COM" created.
14:22:03.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:03.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.176.2 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:03.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.176.2 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:03.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:03.096088  7872 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu
14:22:03.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu
14:22:03.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/wal
14:22:03.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/data
14:22:03.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:22:03.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:22:03.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:22:03.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:22:03.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:22:03.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/logs
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/data/info.pb
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:22:03.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:22:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.176.2:0
14:22:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.176.2
14:22:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.176.2
14:22:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:22:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.176.62:46451
14:22:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab
14:22:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.176.2
14:22:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:22:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:22:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:22:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:22:03.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.176.20:43355
14:22:03.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:22:03.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:22:03.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:22:03.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:22:03.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:22:03.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:22:03.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:03.397140  8134 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:22:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:03.397694  8134 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:22:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:03.397915  8134 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:22:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:03.398507  8134 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:22:03.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:03.432118  8134 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:22:03.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:03.433014  8134 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.176.2
14:22:03.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:03.469484  8134 tablet_server_runner.cc:78] Tablet server non-default flags:
14:22:03.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:22:03.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.176.20:43355
14:22:03.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:22:03.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:22:03.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/data
14:22:03.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/wal
14:22:03.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:22:03.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab
14:22:03.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.176.2
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.176.2:0
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/data/info.pb
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.176.2
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.176.62:46451
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:22:03.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:22:03.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:22:03.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.176.2
14:22:03.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/logs
14:22:03.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:22:03.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:22:03.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:22:03.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:22:03.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:22:03.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:22:03.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:22:03.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:54 UTC on bdcb31816ec0
14:22:03.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15854
14:22:03.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:22:03.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:03.471290  8134 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:22:03.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:03.472558  8134 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:22:03.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:03.485220  8140 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
14:22:04.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.049006  8126 heartbeater.cc:499] Master 127.7.176.62:46451 was elected leader, sending a full tablet report...
14:22:04.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:03.487751  8141 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
14:22:04.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:03.491492  8143 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
14:22:04.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:04.768903  8142 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
14:22:04.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.769057  8134 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
14:22:04.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.773003  8134 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:22:04.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.775581  8134 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:22:04.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.776974  8134 hybrid_clock.cc:648] HybridClock initialized: now 1779114124776943 us; error 39 us; skew 500 ppm
14:22:04.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.777971  8134 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:22:04.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:22:04 dist-test-slave-ss1p krb5kdc[7883](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779114124, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.176.2@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:22:04.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.784245  8134 init.cc:377] Logged in from keytab as kudu/127.7.176.2@KRBTEST.COM (short username kudu)
14:22:04.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.789841  8134 webserver.cc:533] Webserver started at http://127.7.176.2:37587/ using document root <none> and password file <none>
14:22:04.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.791049  8134 fs_manager.cc:362] Metadata directory not provided
14:22:04.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.791250  8134 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:22:04.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.791628  8134 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:22:04.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.795921  8134 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/data/instance:
14:22:04.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c7e17e34deb64048b4a0b761de8e00b7"
14:22:04.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:04 on dist-test-slave-ss1p"
14:22:04.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.796999  8134 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/wal/instance:
14:22:04.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c7e17e34deb64048b4a0b761de8e00b7"
14:22:04.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:04 on dist-test-slave-ss1p"
14:22:04.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.804251  8134 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.006s	sys 0.003s
14:22:04.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.810014  8151 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:22:04.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.811304  8134 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.002s
14:22:04.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.811630  8134 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/data,/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/wal
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c7e17e34deb64048b4a0b761de8e00b7"
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:04 on dist-test-slave-ss1p"
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.811935  8134 fs_report.cc:389] FS layout report
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/wal
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/wal
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/data/data
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:22:04.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:22:04.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:22:04.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:22:04.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.867545  8134 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:22:04.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.872905  8134 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
14:22:04.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.873329  8134 kserver.cc:163] Server-wide thread pool size limit: 3276
14:22:04.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.876178  8134 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:22:04.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.880343  8134 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:22:04.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.880542  8134 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:22:04.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.880728  8134 ts_tablet_manager.cc:616] Registered 0 tablets
14:22:04.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:04.880858  8134 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:22:05.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.021703  8134 rpc_server.cc:307] RPC server started. Bound to: 127.7.176.2:45563
14:22:05.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.021811  8263 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.176.2:45563 every 8 connection(s)
14:22:05.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.024406  8134 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/data/info.pb
14:22:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.029219  7872 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu as pid 8134
14:22:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.029668  7872 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/wal/instance
14:22:05.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:22:05 dist-test-slave-ss1p krb5kdc[7883](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779114124, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.176.2@KRBTEST.COM for kudu/127.7.176.62@KRBTEST.COM
14:22:05.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.176.3@KRBTEST.COM; defaulting to no policy
14:22:05.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:05.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.176.3@KRBTEST.COM" created.
14:22:05.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.061640  8264 heartbeater.cc:344] Connected to a master server at 127.7.176.62:46451
14:22:05.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.062199  8264 heartbeater.cc:461] Registering TS with master...
14:22:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.063580  8264 heartbeater.cc:507] Master 127.7.176.62:46451 requested a full tablet report, sending...
14:22:05.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.066224  7933 ts_manager.cc:194] Registered new tserver with Master: c7e17e34deb64048b4a0b761de8e00b7 (127.7.176.2:45563)
14:22:05.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.067574  7933 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.7.176.2@KRBTEST.COM'} at 127.7.176.2:38527
14:22:05.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:05.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.176.3 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:05.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.176.3 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:05.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.7.176.3@KRBTEST.COM; defaulting to no policy
14:22:05.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:05.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.7.176.3@KRBTEST.COM" created.
14:22:05.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:22:05.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.176.3 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:05.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.176.3 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab.
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.121512  7872 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/wal
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/data
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/logs
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/data/info.pb
14:22:05.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.176.3:0
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.176.3
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.176.3
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.176.62:46451
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.176.3
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:22:05.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:22:05.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.176.20:43355
14:22:05.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:22:05.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:22:05.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:22:05.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:22:05.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:22:05.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:22:05.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:05.431159  8272 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:22:05.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:05.431922  8272 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:22:05.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:05.432286  8272 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:22:05.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:05.433002  8272 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:22:05.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:05.465829  8272 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:22:05.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:05.467020  8272 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.176.3
14:22:05.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.518160  8272 tablet_server_runner.cc:78] Tablet server non-default flags:
14:22:05.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.176.20:43355
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/data
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/wal
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kudu.keytab
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.176.3
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.176.3:0
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:22:05.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/data/info.pb
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.176.3
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.176.62:46451
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.176.3
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/logs
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:22:05.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:22:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:22:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
14:22:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:54 UTC on bdcb31816ec0
14:22:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15854
14:22:05.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
14:22:05.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.527194  8272 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:22:05.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:05.528750  8272 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:22:05.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:05.543738  8278 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
14:22:06.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.071698  8264 heartbeater.cc:499] Master 127.7.176.62:46451 was elected leader, sending a full tablet report...
14:22:06.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:05.544958  8279 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
14:22:06.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:06.796059  8281 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
14:22:06.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:06.799196  8280 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1248 milliseconds
14:22:06.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:06.799458  8272 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.255s	user 0.416s	sys 0.833s
14:22:06.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:06.799815  8272 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.256s	user 0.416s	sys 0.833s
14:22:06.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.800149  8272 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
14:22:06.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.801326  8272 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:22:06.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.803716  8272 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:22:06.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.805132  8272 hybrid_clock.cc:648] HybridClock initialized: now 1779114126805088 us; error 59 us; skew 500 ppm
14:22:06.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.806317  8272 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
14:22:06.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:22:06 dist-test-slave-ss1p krb5kdc[7883](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779114126, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.176.3@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:22:06.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.814066  8272 init.cc:377] Logged in from keytab as kudu/127.7.176.3@KRBTEST.COM (short username kudu)
14:22:06.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.819809  8272 webserver.cc:533] Webserver started at http://127.7.176.3:35065/ using document root <none> and password file <none>
14:22:06.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.820839  8272 fs_manager.cc:362] Metadata directory not provided
14:22:06.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.821100  8272 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:22:06.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.821641  8272 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:22:06.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.826088  8272 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/data/instance:
14:22:06.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2b044d7737804f9c9a4f94c6e255cc43"
14:22:06.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:06 on dist-test-slave-ss1p"
14:22:06.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.827330  8272 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/wal/instance:
14:22:06.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2b044d7737804f9c9a4f94c6e255cc43"
14:22:06.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:06 on dist-test-slave-ss1p"
14:22:06.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.835377  8272 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.006s	sys 0.002s
14:22:06.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.841513  8290 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:22:06.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.842861  8272 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.001s
14:22:06.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.843251  8272 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/data,/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/wal
14:22:06.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2b044d7737804f9c9a4f94c6e255cc43"
14:22:06.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:22:06 on dist-test-slave-ss1p"
14:22:06.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.843675  8272 fs_report.cc:389] FS layout report
14:22:06.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:22:06.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/wal
14:22:06.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/wal
14:22:06.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/data/data
14:22:06.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:22:06.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:22:06.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:22:06.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:22:06.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:22:06.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:22:06.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:22:06.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:22:06.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:22:06.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:22:06.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:22:06.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.919729  8272 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:22:06.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.925621  8272 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
14:22:06.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.926175  8272 kserver.cc:163] Server-wide thread pool size limit: 3276
14:22:06.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.929499  8272 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:22:06.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.933904  8272 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:22:06.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.934144  8272 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.001s	sys 0.000s
14:22:06.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.934427  8272 ts_tablet_manager.cc:616] Registered 0 tablets
14:22:06.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:06.934633  8272 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:22:07.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:07.080327  8272 rpc_server.cc:307] RPC server started. Bound to: 127.7.176.3:42709
14:22:07.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:07.080444  8402 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.176.3:42709 every 8 connection(s)
14:22:07.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:07.083463  8272 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/data/info.pb
14:22:07.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:07.087589  7872 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu as pid 8272
14:22:07.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:07.088301  7872 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/wal/instance
14:22:07.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:22:07 dist-test-slave-ss1p krb5kdc[7883](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779114126, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.176.3@KRBTEST.COM for kudu/127.7.176.62@KRBTEST.COM
14:22:07.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:07.115834  8403 heartbeater.cc:344] Connected to a master server at 127.7.176.62:46451
14:22:07.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:07.116348  8403 heartbeater.cc:461] Registering TS with master...
14:22:07.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:07.117343  8403 heartbeater.cc:507] Master 127.7.176.62:46451 requested a full tablet report, sending...
14:22:07.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:07.119623  7933 ts_manager.cc:194] Registered new tserver with Master: 2b044d7737804f9c9a4f94c6e255cc43 (127.7.176.3:42709)
14:22:07.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:07.121050  7933 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.7.176.3@KRBTEST.COM'} at 127.7.176.3:47471
14:22:07.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:07.123919  7872 external_mini_cluster.cc:949] 3 TS(s) registered with all masters
14:22:07.135 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:22:07.136 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

14:22:07.145 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

14:22:07.146 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

14:22:07.154 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.176.62"
      port: 46451
    }
    bound_http_address {
      host: "127.7.176.62"
      port: 35225
    }
  }
}

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

14:22:07.159 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.176.1"
      port: 46641
    }
    bound_http_address {
      host: "127.7.176.1"
      port: 34379
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.7.176.2"
      port: 45563
    }
    bound_http_address {
      host: "127.7.176.2"
      port: 37587
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.7.176.3"
      port: 42709
    }
    bound_http_address {
      host: "127.7.176.3"
      port: 35065
    }
  }
}

14:22:07.160 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
14:22:07.366 [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)
14:22:07.390 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/krb5kdc/krb5cc
14:22:07.443 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
14:22:07.582 [DEBUG - main] (Connection.java:748) [peer master-127.7.176.62:46451(127.7.176.62:46451)] connecting to peer
14:22:07.660 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.7.176.62:46451(127.7.176.62:46451)] Successfully connected to peer
14:22:07.755 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.7.176.62
14:22:07.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:22:07 dist-test-slave-ss1p krb5kdc[7883](info): TGS_REQ (1 etypes {17}) 127.0.0.1: ISSUE: authtime 1779114118, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.7.176.62@KRBTEST.COM
14:22:08.034 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x76263d75, L:/127.0.0.1:32906 - R:/127.7.176.62:46451] using SASL/GSSAPI
14:22:08.073 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:22:08.074 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTabletServers, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=538), Traces: [0ms] refreshing cache from master, [28ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.176.62:46451, [510ms] Sub RPC ConnectToMaster: received response from server master-127.7.176.62:46451: OK, deferred=null) after lookup
14:22:08.095 [DEBUG - main] (Connection.java:575) [peer master-127.7.176.62:46451(127.7.176.62:46451)] disconnecting while in state READY
14:22:08.102 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.7.176.62:46451(127.7.176.62:46451)] handling channelInactive
14:22:08.103 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.7.176.62:46451(127.7.176.62:46451)] cleaning up while in state READY due to: connection closed
14:22:08.104 [INFO - kudu-nio-0] (AsyncKuduClient.java:2355) Invalidating location master-127.7.176.62:46451(127.7.176.62:46451) for tablet Kudu Master: connection closed
14:22:08.118 [DEBUG - pool-2-thread-1] (Connection.java:748) [peer master-127.7.176.62:46451(127.7.176.62:46451)] connecting to peer
14:22:08.120 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.7.176.62:46451(127.7.176.62:46451)] Successfully connected to peer
14:22:08.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.124943  8403 heartbeater.cc:499] Master 127.7.176.62:46451 was elected leader, sending a full tablet report...
14:22:08.182 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x56a6f259, L:/127.0.0.1:32918 - R:/127.7.176.62:46451] using TOKEN/null
14:22:08.186 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:22:08.187 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=Kudu Master, attempt=2, TimeoutTracker(timeout=50000, elapsed=90), Traces: [0ms] sending RPC to server master-127.7.176.62:46451, [6ms] received response from server master-127.7.176.62:46451: Network error: connection closed, [7ms] delaying RPC due to: Network error: connection closed, [20ms] refreshing cache from master, [20ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.176.62:46451, [89ms] Sub RPC ConnectToMaster: received response from server master-127.7.176.62:46451: OK, deferred=Deferred@1837069769(state=PENDING, result=null, callback=wakeup thread main, errback=wakeup thread main)) after lookup
14:22:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.252890  7933 catalog_manager.cc:2283] Servicing CreateTable request from {username='test-admin'} at 127.0.0.1:32918:
14:22:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "TestAuthnTokenReacquireOpen-table"
14:22:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
14:22:08.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:22:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
14:22:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:22:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
14:22:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:22:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:22:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:22:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:22:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:22:08.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:22:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
14:22:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:22:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:22:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:22:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:22:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:22:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:22:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:22:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:22:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
14:22:08.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:22:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:22:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:22:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:22:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:22:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:22:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:22:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:22:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
14:22:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
14:22:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:22:08.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:22:08.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:22:08.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
14:22:08.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
14:22:08.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
14:22:08.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
14:22:08.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:22:08.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:22:08.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:22:08.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:08.277753  7933 catalog_manager.cc:7059] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table TestAuthnTokenReacquireOpen-table in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
14:22:08.341 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 0b2d2691e13146cc9e32cc1ae977c565
14:22:08.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.371137  8199 tablet_service.cc:1511] Processing CreateTablet for tablet 327f5b697b5e4be7b5576f6e9c61674e (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=0b2d2691e13146cc9e32cc1ae977c565]), partition=RANGE (key) PARTITION UNBOUNDED
14:22:08.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.373510  8199 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 327f5b697b5e4be7b5576f6e9c61674e. 1 dirs total, 0 dirs full, 0 dirs failed
14:22:08.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.372978  8061 tablet_service.cc:1511] Processing CreateTablet for tablet 327f5b697b5e4be7b5576f6e9c61674e (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=0b2d2691e13146cc9e32cc1ae977c565]), partition=RANGE (key) PARTITION UNBOUNDED
14:22:08.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.375733  8061 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 327f5b697b5e4be7b5576f6e9c61674e. 1 dirs total, 0 dirs full, 0 dirs failed
14:22:08.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.382889  8338 tablet_service.cc:1511] Processing CreateTablet for tablet 327f5b697b5e4be7b5576f6e9c61674e (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=0b2d2691e13146cc9e32cc1ae977c565]), partition=RANGE (key) PARTITION UNBOUNDED
14:22:08.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.385298  8338 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 327f5b697b5e4be7b5576f6e9c61674e. 1 dirs total, 0 dirs full, 0 dirs failed
14:22:08.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.427659  8422 tablet_bootstrap.cc:492] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: Bootstrap starting.
14:22:08.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.439303  8422 tablet_bootstrap.cc:654] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: Neither blocks nor log segments found. Creating new log.
14:22:08.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.441355  8424 tablet_bootstrap.cc:492] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: Bootstrap starting.
14:22:08.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.441699  8422 log.cc:826] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: Log is configured to *not* fsync() on all Append() calls
14:22:08.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.445289  8423 tablet_bootstrap.cc:492] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: Bootstrap starting.
14:22:08.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.453616  8423 tablet_bootstrap.cc:654] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: Neither blocks nor log segments found. Creating new log.
14:22:08.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.456684  8423 log.cc:826] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: Log is configured to *not* fsync() on all Append() calls
14:22:08.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.469300  8423 tablet_bootstrap.cc:492] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: No bootstrap required, opened a new log
14:22:08.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.470389  8423 ts_tablet_manager.cc:1403] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: Time spent bootstrapping tablet: real 0.028s	user 0.008s	sys 0.015s
14:22:08.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.470768  8424 tablet_bootstrap.cc:654] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: Neither blocks nor log segments found. Creating new log.
14:22:08.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.474550  8424 log.cc:826] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: Log is configured to *not* fsync() on all Append() calls
14:22:08.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.476179  8422 tablet_bootstrap.cc:492] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: No bootstrap required, opened a new log
14:22:08.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.477214  8422 ts_tablet_manager.cc:1403] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: Time spent bootstrapping tablet: real 0.051s	user 0.028s	sys 0.014s
14:22:08.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.493449  8424 tablet_bootstrap.cc:492] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: No bootstrap required, opened a new log
14:22:08.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.494326  8424 ts_tablet_manager.cc:1403] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: Time spent bootstrapping tablet: real 0.054s	user 0.016s	sys 0.003s
14:22:08.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.506062  8422 raft_consensus.cc:359] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c7e17e34deb64048b4a0b761de8e00b7" member_type: VOTER last_known_addr { host: "127.7.176.2" port: 45563 } } peers { permanent_uuid: "2b044d7737804f9c9a4f94c6e255cc43" member_type: VOTER last_known_addr { host: "127.7.176.3" port: 42709 } } peers { permanent_uuid: "aafd1029f0a24b31beab50faf80ce92a" member_type: VOTER last_known_addr { host: "127.7.176.1" port: 46641 } }
14:22:08.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.507418  8422 raft_consensus.cc:385] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:22:08.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.507968  8422 raft_consensus.cc:740] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c7e17e34deb64048b4a0b761de8e00b7, State: Initialized, Role: FOLLOWER
14:22:08.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.509240  8422 consensus_queue.cc:260] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7 [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: "c7e17e34deb64048b4a0b761de8e00b7" member_type: VOTER last_known_addr { host: "127.7.176.2" port: 45563 } } peers { permanent_uuid: "2b044d7737804f9c9a4f94c6e255cc43" member_type: VOTER last_known_addr { host: "127.7.176.3" port: 42709 } } peers { permanent_uuid: "aafd1029f0a24b31beab50faf80ce92a" member_type: VOTER last_known_addr { host: "127.7.176.1" port: 46641 } }
14:22:08.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.522181  8422 ts_tablet_manager.cc:1434] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: Time spent starting tablet: real 0.044s	user 0.031s	sys 0.007s
14:22:08.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.531167  8423 raft_consensus.cc:359] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c7e17e34deb64048b4a0b761de8e00b7" member_type: VOTER last_known_addr { host: "127.7.176.2" port: 45563 } } peers { permanent_uuid: "2b044d7737804f9c9a4f94c6e255cc43" member_type: VOTER last_known_addr { host: "127.7.176.3" port: 42709 } } peers { permanent_uuid: "aafd1029f0a24b31beab50faf80ce92a" member_type: VOTER last_known_addr { host: "127.7.176.1" port: 46641 } }
14:22:08.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:08.533435  8265 tablet.cc:2404] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:22:08.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.534041  8423 raft_consensus.cc:385] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:22:08.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.534379  8423 raft_consensus.cc:740] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: aafd1029f0a24b31beab50faf80ce92a, State: Initialized, Role: FOLLOWER
14:22:08.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.535689  8423 consensus_queue.cc:260] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [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: "c7e17e34deb64048b4a0b761de8e00b7" member_type: VOTER last_known_addr { host: "127.7.176.2" port: 45563 } } peers { permanent_uuid: "2b044d7737804f9c9a4f94c6e255cc43" member_type: VOTER last_known_addr { host: "127.7.176.3" port: 42709 } } peers { permanent_uuid: "aafd1029f0a24b31beab50faf80ce92a" member_type: VOTER last_known_addr { host: "127.7.176.1" port: 46641 } }
14:22:08.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.541208  8424 raft_consensus.cc:359] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c7e17e34deb64048b4a0b761de8e00b7" member_type: VOTER last_known_addr { host: "127.7.176.2" port: 45563 } } peers { permanent_uuid: "2b044d7737804f9c9a4f94c6e255cc43" member_type: VOTER last_known_addr { host: "127.7.176.3" port: 42709 } } peers { permanent_uuid: "aafd1029f0a24b31beab50faf80ce92a" member_type: VOTER last_known_addr { host: "127.7.176.1" port: 46641 } }
14:22:08.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.542186  8424 raft_consensus.cc:385] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:22:08.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.542461  8424 raft_consensus.cc:740] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 2b044d7737804f9c9a4f94c6e255cc43, State: Initialized, Role: FOLLOWER
14:22:08.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.543380  8424 consensus_queue.cc:260] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43 [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: "c7e17e34deb64048b4a0b761de8e00b7" member_type: VOTER last_known_addr { host: "127.7.176.2" port: 45563 } } peers { permanent_uuid: "2b044d7737804f9c9a4f94c6e255cc43" member_type: VOTER last_known_addr { host: "127.7.176.3" port: 42709 } } peers { permanent_uuid: "aafd1029f0a24b31beab50faf80ce92a" member_type: VOTER last_known_addr { host: "127.7.176.1" port: 46641 } }
14:22:08.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.547226  8424 ts_tablet_manager.cc:1434] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: Time spent starting tablet: real 0.053s	user 0.033s	sys 0.001s
14:22:08.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.547359  8423 ts_tablet_manager.cc:1434] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: Time spent starting tablet: real 0.076s	user 0.020s	sys 0.020s
14:22:08.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.551260  8429 raft_consensus.cc:493] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:22:08.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.552541  8429 raft_consensus.cc:515] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c7e17e34deb64048b4a0b761de8e00b7" member_type: VOTER last_known_addr { host: "127.7.176.2" port: 45563 } } peers { permanent_uuid: "2b044d7737804f9c9a4f94c6e255cc43" member_type: VOTER last_known_addr { host: "127.7.176.3" port: 42709 } } peers { permanent_uuid: "aafd1029f0a24b31beab50faf80ce92a" member_type: VOTER last_known_addr { host: "127.7.176.1" port: 46641 } }
14:22:08.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.558573  8429 leader_election.cc:290] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers c7e17e34deb64048b4a0b761de8e00b7 (127.7.176.2:45563), 2b044d7737804f9c9a4f94c6e255cc43 (127.7.176.3:42709)
14:22:08.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.571898  8219 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "327f5b697b5e4be7b5576f6e9c61674e" candidate_uuid: "aafd1029f0a24b31beab50faf80ce92a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c7e17e34deb64048b4a0b761de8e00b7" is_pre_election: true
14:22:08.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.572965  8219 raft_consensus.cc:2468] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate aafd1029f0a24b31beab50faf80ce92a in term 0.
14:22:08.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.574239  8358 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "327f5b697b5e4be7b5576f6e9c61674e" candidate_uuid: "aafd1029f0a24b31beab50faf80ce92a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "2b044d7737804f9c9a4f94c6e255cc43" is_pre_election: true
14:22:08.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.574699  8017 leader_election.cc:304] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [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: aafd1029f0a24b31beab50faf80ce92a, c7e17e34deb64048b4a0b761de8e00b7; no voters: 
14:22:08.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.575183  8358 raft_consensus.cc:2468] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate aafd1029f0a24b31beab50faf80ce92a in term 0.
14:22:08.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.576188  8429 raft_consensus.cc:2804] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 0 FOLLOWER]: Leader pre-election won for term 1
14:22:08.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.576574  8429 raft_consensus.cc:493] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:22:08.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.576924  8429 raft_consensus.cc:3060] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 0 FOLLOWER]: Advancing to term 1
14:22:08.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.583401  8429 raft_consensus.cc:515] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c7e17e34deb64048b4a0b761de8e00b7" member_type: VOTER last_known_addr { host: "127.7.176.2" port: 45563 } } peers { permanent_uuid: "2b044d7737804f9c9a4f94c6e255cc43" member_type: VOTER last_known_addr { host: "127.7.176.3" port: 42709 } } peers { permanent_uuid: "aafd1029f0a24b31beab50faf80ce92a" member_type: VOTER last_known_addr { host: "127.7.176.1" port: 46641 } }
14:22:08.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.585264  8429 leader_election.cc:290] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [CANDIDATE]: Term 1 election: Requested vote from peers c7e17e34deb64048b4a0b761de8e00b7 (127.7.176.2:45563), 2b044d7737804f9c9a4f94c6e255cc43 (127.7.176.3:42709)
14:22:08.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.586274  8219 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "327f5b697b5e4be7b5576f6e9c61674e" candidate_uuid: "aafd1029f0a24b31beab50faf80ce92a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c7e17e34deb64048b4a0b761de8e00b7"
14:22:08.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.586477  8358 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "327f5b697b5e4be7b5576f6e9c61674e" candidate_uuid: "aafd1029f0a24b31beab50faf80ce92a" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "2b044d7737804f9c9a4f94c6e255cc43"
14:22:08.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.586807  8219 raft_consensus.cc:3060] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7 [term 0 FOLLOWER]: Advancing to term 1
14:22:08.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.587001  8358 raft_consensus.cc:3060] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43 [term 0 FOLLOWER]: Advancing to term 1
14:22:08.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:08.589490  8404 tablet.cc:2404] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:22:08.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.592423  8219 raft_consensus.cc:2468] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate aafd1029f0a24b31beab50faf80ce92a in term 1.
14:22:08.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.593565  8017 leader_election.cc:304] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [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: aafd1029f0a24b31beab50faf80ce92a, c7e17e34deb64048b4a0b761de8e00b7; no voters: 
14:22:08.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.593897  8358 raft_consensus.cc:2468] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate aafd1029f0a24b31beab50faf80ce92a in term 1.
14:22:08.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.594542  8429 raft_consensus.cc:2804] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 1 FOLLOWER]: Leader election won for term 1
14:22:08.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.595269  8429 raft_consensus.cc:697] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 1 LEADER]: Becoming Leader. State: Replica: aafd1029f0a24b31beab50faf80ce92a, State: Running, Role: LEADER
14:22:08.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.596184  8429 consensus_queue.cc:237] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [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: "c7e17e34deb64048b4a0b761de8e00b7" member_type: VOTER last_known_addr { host: "127.7.176.2" port: 45563 } } peers { permanent_uuid: "2b044d7737804f9c9a4f94c6e255cc43" member_type: VOTER last_known_addr { host: "127.7.176.3" port: 42709 } } peers { permanent_uuid: "aafd1029f0a24b31beab50faf80ce92a" member_type: VOTER last_known_addr { host: "127.7.176.1" port: 46641 } }
14:22:08.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:08.609789  7932 catalog_manager.cc:5697] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a reported cstate change: term changed from 0 to 1, leader changed from <none> to aafd1029f0a24b31beab50faf80ce92a (127.7.176.1). New cstate: current_term: 1 leader_uuid: "aafd1029f0a24b31beab50faf80ce92a" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c7e17e34deb64048b4a0b761de8e00b7" member_type: VOTER last_known_addr { host: "127.7.176.2" port: 45563 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "2b044d7737804f9c9a4f94c6e255cc43" member_type: VOTER last_known_addr { host: "127.7.176.3" port: 42709 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "aafd1029f0a24b31beab50faf80ce92a" member_type: VOTER last_known_addr { host: "127.7.176.1" port: 46641 } health_report { overall_health: HEALTHY } } }
14:22:08.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:08.761543  8127 tablet.cc:2404] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:22:08.787 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 0b2d2691e13146cc9e32cc1ae977c565
14:22:09.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.115295  8436 consensus_queue.cc:1048] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [LEADER]: Connected to new peer: Peer: permanent_uuid: "2b044d7737804f9c9a4f94c6e255cc43" member_type: VOTER last_known_addr { host: "127.7.176.3" port: 42709 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:22:09.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.137112  8439 consensus_queue.cc:1048] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [LEADER]: Connected to new peer: Peer: permanent_uuid: "c7e17e34deb64048b4a0b761de8e00b7" member_type: VOTER last_known_addr { host: "127.7.176.2" port: 45563 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:22:09.792 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 0b2d2691e13146cc9e32cc1ae977c565
14:22:09.815 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 327f5b697b5e4be7b5576f6e9c61674e for table 'TestAuthnTokenReacquireOpen-table' with partition [<start>, <end>)
14:22:09.821 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=327f5b697b5e4be7b5576f6e9c61674e@[2b044d7737804f9c9a4f94c6e255cc43(127.7.176.3:42709),aafd1029f0a24b31beab50faf80ce92a(127.7.176.1:46641)[L],c7e17e34deb64048b4a0b761de8e00b7(127.7.176.2:45563)]}]
14:22:09.828 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC ScanRequest(scannerId=null, state=OPENING, attempt=1, KuduRpc(method=Scan, tablet=null, attempt=1, TimeoutTracker(timeout=60000, elapsed=16), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.7.176.62:46451, [8ms] Sub RPC GetTableLocations: received response from server master-127.7.176.62:46451: OK, deferred=null)) after lookup
14:22:09.838 [DEBUG - kudu-nio-1] (Connection.java:748) [peer aafd1029f0a24b31beab50faf80ce92a(127.7.176.1:46641)] connecting to peer
14:22:09.841 [DEBUG - kudu-nio-2] (Connection.java:757) [peer aafd1029f0a24b31beab50faf80ce92a(127.7.176.1:46641)] Successfully connected to peer
14:22:09.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:09.886369  8449 fault_injection.cc:43] FAULT INJECTION ENABLED!
14:22:09.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:22:09.886660  8449 fault_injection.cc:44] THIS SERVER MAY CRASH!
14:22:09.888 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x4eafbea2, L:/127.0.0.1:56812 - R:/127.7.176.1:46641] using TOKEN/null
14:22:09.921 [DEBUG - kudu-nio-2] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 0 rows, more = false) for scanner KuduScanner(table=TestAuthnTokenReacquireOpen-table, tablet=327f5b697b5e4be7b5576f6e9c61674e, scannerId=null, scanRequestTimeout=60000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:22:09.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.933733  7932 catalog_manager.cc:2533] Servicing SoftDeleteTable request from {username='test-admin'} at 127.0.0.1:32918:
14:22:09.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
14:22:09.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.934530  7932 catalog_manager.cc:2781] Servicing DeleteTable request from {username='test-admin'} at 127.0.0.1:32918:
14:22:09.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
14:22:09.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.954139  7932 catalog_manager.cc:5984] T 00000000000000000000000000000000 P 87968bd9bab6479697dc4617d6953a75: Sending DeleteTablet for 3 replicas of tablet 327f5b697b5e4be7b5576f6e9c61674e
14:22:09.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.956857  8199 tablet_service.cc:1558] Processing DeleteTablet for tablet 327f5b697b5e4be7b5576f6e9c61674e with delete_type TABLET_DATA_DELETED (Table deleted at 2026-05-18 14:22:09 UTC) from {username='kudu', principal='kudu/127.7.176.62@KRBTEST.COM'} at 127.0.0.1:55468
14:22:09.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.958703  8338 tablet_service.cc:1558] Processing DeleteTablet for tablet 327f5b697b5e4be7b5576f6e9c61674e with delete_type TABLET_DATA_DELETED (Table deleted at 2026-05-18 14:22:09 UTC) from {username='kudu', principal='kudu/127.7.176.62@KRBTEST.COM'} at 127.0.0.1:51964
14:22:09.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.959909  8061 tablet_service.cc:1558] Processing DeleteTablet for tablet 327f5b697b5e4be7b5576f6e9c61674e with delete_type TABLET_DATA_DELETED (Table deleted at 2026-05-18 14:22:09 UTC) from {username='kudu', principal='kudu/127.7.176.62@KRBTEST.COM'} at 127.0.0.1:56796
14:22:09.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.966938  8458 tablet_replica.cc:333] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: stopping tablet replica
14:22:09.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.974426  8457 tablet_replica.cc:333] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: stopping tablet replica
14:22:09.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.975831  8456 tablet_replica.cc:333] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: stopping tablet replica
14:22:09.976 [DEBUG - main] (Connection.java:575) [peer master-127.7.176.62:46451(127.7.176.62:46451)] disconnecting while in state READY
14:22:09.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.975827  8458 raft_consensus.cc:2243] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43 [term 1 FOLLOWER]: Raft consensus shutting down.
14:22:09.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.976466  8458 raft_consensus.cc:2272] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43 [term 1 FOLLOWER]: Raft consensus is shut down!
14:22:09.976 [DEBUG - main] (Connection.java:575) [peer aafd1029f0a24b31beab50faf80ce92a(127.7.176.1:46641)] disconnecting while in state READY
14:22:09.979 [DEBUG - kudu-nio-2] (Connection.java:239) [peer aafd1029f0a24b31beab50faf80ce92a(127.7.176.1:46641)] handling channelInactive
14:22:09.980 [DEBUG - kudu-nio-2] (Connection.java:709) [peer aafd1029f0a24b31beab50faf80ce92a(127.7.176.1:46641)] cleaning up while in state READY due to: connection closed
14:22:09.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.979907  8458 ts_tablet_manager.cc:1916] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: Deleting tablet data with delete state TABLET_DATA_DELETED
14:22:09.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.981515  8457 raft_consensus.cc:2243] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 1 LEADER]: Raft consensus shutting down.
14:22:09.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.982574  8456 raft_consensus.cc:2243] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7 [term 1 FOLLOWER]: Raft consensus shutting down.
14:22:09.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.983230  8456 raft_consensus.cc:2272] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7 [term 1 FOLLOWER]: Raft consensus is shut down!
14:22:09.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.984638  8457 raft_consensus.cc:2272] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a [term 1 FOLLOWER]: Raft consensus is shut down!
14:22:09.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:09.987337  8456 ts_tablet_manager.cc:1916] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: Deleting tablet data with delete state TABLET_DATA_DELETED
14:22:10.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.002429  8456 ts_tablet_manager.cc:1929] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:22:10.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.003266  8456 log.cc:1199] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: Deleting WAL directory at /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-1/wal/wals/327f5b697b5e4be7b5576f6e9c61674e
14:22:10.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.004415  8456 ts_tablet_manager.cc:1950] T 327f5b697b5e4be7b5576f6e9c61674e P c7e17e34deb64048b4a0b761de8e00b7: Deleting consensus metadata
14:22:10.006 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:22:10.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.008939  8457 ts_tablet_manager.cc:1916] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: Deleting tablet data with delete state TABLET_DATA_DELETED
14:22:10.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.009073  7920 catalog_manager.cc:5028] TS c7e17e34deb64048b4a0b761de8e00b7 (127.7.176.2:45563): tablet 327f5b697b5e4be7b5576f6e9c61674e (table TestAuthnTokenReacquireOpen-table [id=0b2d2691e13146cc9e32cc1ae977c565]) successfully deleted
14:22:10.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.024742  8457 ts_tablet_manager.cc:1929] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:22:10.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.025543  8457 log.cc:1199] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: Deleting WAL directory at /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-0/wal/wals/327f5b697b5e4be7b5576f6e9c61674e
14:22:10.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.026647  8457 ts_tablet_manager.cc:1950] T 327f5b697b5e4be7b5576f6e9c61674e P aafd1029f0a24b31beab50faf80ce92a: Deleting consensus metadata
14:22:10.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.030310  7917 catalog_manager.cc:5028] TS aafd1029f0a24b31beab50faf80ce92a (127.7.176.1:46641): tablet 327f5b697b5e4be7b5576f6e9c61674e (table TestAuthnTokenReacquireOpen-table [id=0b2d2691e13146cc9e32cc1ae977c565]) successfully deleted
14:22:10.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.032213  8458 ts_tablet_manager.cc:1929] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:22:10.032 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.7.176.62:46451(127.7.176.62:46451)] handling channelInactive
14:22:10.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.032614  7872 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu with pid 7996
14:22:10.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.033836  8458 log.cc:1199] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: Deleting WAL directory at /tmp/dist-test-taskoCowaL/test-tmp/mini-kudu-cluster297624272421065787/ts-2/wal/wals/327f5b697b5e4be7b5576f6e9c61674e
14:22:10.034 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.7.176.62:46451(127.7.176.62:46451)] cleaning up while in state READY due to: connection closed
14:22:10.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.034852  8458 ts_tablet_manager.cc:1950] T 327f5b697b5e4be7b5576f6e9c61674e P 2b044d7737804f9c9a4f94c6e255cc43: Deleting consensus metadata
14:22:10.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.038264  7918 catalog_manager.cc:5028] TS 2b044d7737804f9c9a4f94c6e255cc43 (127.7.176.3:42709): tablet 327f5b697b5e4be7b5576f6e9c61674e (table TestAuthnTokenReacquireOpen-table [id=0b2d2691e13146cc9e32cc1ae977c565]) successfully deleted
14:22:10.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.061503  7872 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu with pid 8134
14:22:10.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.093888  7872 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu with pid 8272
14:22:10.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:22:10.119848  7872 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskoCowaL/build/tsan/bin/kudu with pid 7899
14:22:11.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:22:11Z chronyd exiting

Time: 16.621

OK (1 test)

