JUnit version 4.13.2
.20:03:31.453 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783541011443
20:03:31.492 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
20:03:31.549 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
20:03:31.557 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskxDOXSZ/test-tmp
20:03:31.562 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
20:03:31.565 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskxDOXSZ/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
20:03:31.766 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886"
  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 {
  }
}

20:03:31.946 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
20:03:31.948 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

20:03:31.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:31.951658 13139 mini_oidc.cc:150] Starting JWKS server
20:03:31.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:31.955562 13139 webserver.cc:533] Webserver started at http://127.0.0.1:34023/ using document root <none> and password file <none>
20:03:31.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:31.955988 13139 mini_oidc.cc:186] Starting OIDC Discovery server
20:03:31.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:31.957831 13139 webserver.cc:533] Webserver started at http://127.0.0.1:39385/ using document root <none> and password file <none>
20:03:32.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
20:03:32.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/principal' for realm 'KRBTEST.COM',
20:03:32.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
20:03:32.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:32 dist-test-slave-815n krb5kdc[13150](info): setting up network...
20:03:32.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
20:03:32.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:32 dist-test-slave-815n krb5kdc[13150](info): set up 2 sockets
20:03:32.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:32 dist-test-slave-815n krb5kdc[13150](info): commencing operation
20:03:32.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
20:03:34.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.007284 13139 mini_kdc.cc:121] Time spent starting KDC: real 2.012s	user 0.002s	sys 0.016s
20:03:34.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
20:03:34.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
20:03:34.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
20:03:34.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
20:03:34.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
20:03:34.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
20:03:34.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
20:03:34.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
20:03:34.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
20:03:34.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
20:03:34.116 [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-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/test-user.keytab.
20:03:34.116 [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-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/test-user.keytab.
20:03:34.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:34 dist-test-slave-815n krb5kdc[13150](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783541014, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
20:03:34.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
20:03:34.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T20:03:34Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
20:03:34.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T20:03:34Z Disabled control of system clock
20:03:34.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.12.212.254@KRBTEST.COM; defaulting to no policy
20:03:34.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:34.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.12.212.254@KRBTEST.COM" created.
20:03:34.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:34.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.12.212.254 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:34.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.12.212.254 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:34.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.12.212.254@KRBTEST.COM; defaulting to no policy
20:03:34.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:34.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.12.212.254@KRBTEST.COM" created.
20:03:34.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:34.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.12.212.254 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:34.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.12.212.254 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:34.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:34.232527 13139 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu
20:03:34.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu
20:03:34.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/wal
20:03:34.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/data
20:03:34.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:34.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:34.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:34.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:34.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:34.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:34.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/logs
20:03:34.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/data/info.pb
20:03:34.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:34.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:34.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:34.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:34.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:34.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:34.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:34.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:34.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
20:03:34.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:34.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:03:34.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:03:34.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.212.254:42391
20:03:34.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.212.254
20:03:34.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:34.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab
20:03:34.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.12.212.254
20:03:34.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
20:03:34.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
20:03:34.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
20:03:34.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
20:03:34.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.212.212:37137
20:03:34.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:34.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:34.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:34.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:03:34.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.212.254:42391
20:03:34.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:03:34.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34023/jwks.json
20:03:34.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
20:03:34.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
20:03:34.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000 with env {KRB5CCNAME=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
20:03:34.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.527559 13166 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:34.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.528107 13166 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:34.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.528903 13166 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:34.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.561910 13166 flags.cc:432] Enabled experimental flag: --authn_token_validity_seconds=1
20:03:34.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.562139 13166 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
20:03:34.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.562399 13166 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:34.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.562642 13166 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
20:03:34.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.562956 13166 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
20:03:34.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.563299 13166 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
20:03:34.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.563553 13166 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:34023/jwks.json
20:03:34.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:34.601408 13166 master_runner.cc:387] Master server non-default flags:
20:03:34.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:34.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.212.212:37137
20:03:34.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:34.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:34.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/data
20:03:34.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/wal
20:03:34.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
20:03:34.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:03:34.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.212.254:42391
20:03:34.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab
20:03:34.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.12.212.254
20:03:34.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:34.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:34.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:03:34.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.212.254:42391
20:03:34.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:03:34.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:34.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:03:34.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34023/jwks.json
20:03:34.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
20:03:34.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
20:03:34.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
20:03:34.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
20:03:34.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:34.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:34.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/data/info.pb
20:03:34.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.212.254
20:03:34.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:34.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:34.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:34.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:34.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:34.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:34.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/logs
20:03:34.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:34.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:34.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:34.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
20:03:34.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:34.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
20:03:34.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:03:34.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:23 UTC on e7f111948823
20:03:34.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12779
20:03:34.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:03:34.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:34.602802 13166 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:34.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:34.604096 13166 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:34.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.616621 13172 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
20:03:35.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:34.618456 13173 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
20:03:35.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:35.807934 13174 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1189 milliseconds
20:03:35.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:35.808694 13175 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
20:03:35.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.809253 13166 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
20:03:35.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.812458 13166 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:35.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.815078 13166 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:35.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.816409 13166 hybrid_clock.cc:648] HybridClock initialized: now 1783541015816365 us; error 77 us; skew 500 ppm
20:03:35.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.817343 13166 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:03:35.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:35 dist-test-slave-815n krb5kdc[13150](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783541015, etypes {rep=17 tkt=17 ses=17}, kudu/127.12.212.254@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
20:03:35.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.823556 13166 init.cc:377] Logged in from keytab as kudu/127.12.212.254@KRBTEST.COM (short username kudu)
20:03:35.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.829753 13166 webserver.cc:533] Webserver started at http://127.12.212.254:37565/ using document root <none> and password file <none>
20:03:35.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.830952 13166 fs_manager.cc:362] Metadata directory not provided
20:03:35.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.831225 13166 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:35.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.831705 13166 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:35.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.835798 13166 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/data/instance:
20:03:35.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dce7824989c247808f97cbfb70742e2c"
20:03:35.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:35 on dist-test-slave-815n"
20:03:35.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.836845 13166 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/wal/instance:
20:03:35.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dce7824989c247808f97cbfb70742e2c"
20:03:35.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:35 on dist-test-slave-815n"
20:03:35.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.844045 13166 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.009s	sys 0.000s
20:03:35.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.849293 13183 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:35.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.850427 13166 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
20:03:35.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.850782 13166 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/data,/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/wal
20:03:35.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dce7824989c247808f97cbfb70742e2c"
20:03:35.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:35 on dist-test-slave-815n"
20:03:35.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.851167 13166 fs_report.cc:389] FS layout report
20:03:35.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:35.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/wal
20:03:35.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/wal
20:03:35.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/data/data
20:03:35.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:35.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:35.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:35.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:35.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:35.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:35.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:35.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:35.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:35.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:35.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:35.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.921887 13166 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:35.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.932523 13166 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
20:03:35.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:35.933044 13166 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:36.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.002329 13166 rpc_server.cc:307] RPC server started. Bound to: 127.12.212.254:42391
20:03:36.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.002404 13234 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.212.254:42391 every 8 connection(s)
20:03:36.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.005486 13166 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/data/info.pb
20:03:36.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.012094 13235 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:36.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.014056 13139 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu as pid 13166
20:03:36.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.014595 13139 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/master-0/wal/instance
20:03:36.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.034780 13235 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c: Bootstrap starting.
20:03:36.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.040208 13235 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c: Neither blocks nor log segments found. Creating new log.
20:03:36.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.042023 13235 log.cc:826] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c: Log is configured to *not* fsync() on all Append() calls
20:03:36.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.047195 13235 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c: No bootstrap required, opened a new log
20:03:36.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:36 dist-test-slave-815n krb5kdc[13150](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783541014, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.12.212.254@KRBTEST.COM
20:03:36.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.065125 13235 raft_consensus.cc:359] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "dce7824989c247808f97cbfb70742e2c" member_type: VOTER last_known_addr { host: "127.12.212.254" port: 42391 } }
20:03:36.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.065886 13235 raft_consensus.cc:385] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:36.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.066162 13235 raft_consensus.cc:740] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: dce7824989c247808f97cbfb70742e2c, State: Initialized, Role: FOLLOWER
20:03:36.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.066970 13235 consensus_queue.cc:260] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [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: "dce7824989c247808f97cbfb70742e2c" member_type: VOTER last_known_addr { host: "127.12.212.254" port: 42391 } }
20:03:36.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.067502 13235 raft_consensus.cc:399] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
20:03:36.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.067819 13235 raft_consensus.cc:493] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
20:03:36.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.068192 13235 raft_consensus.cc:3060] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [term 0 FOLLOWER]: Advancing to term 1
20:03:36.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.073218 13235 raft_consensus.cc:515] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "dce7824989c247808f97cbfb70742e2c" member_type: VOTER last_known_addr { host: "127.12.212.254" port: 42391 } }
20:03:36.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.074018 13235 leader_election.cc:304] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [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: dce7824989c247808f97cbfb70742e2c; no voters: 
20:03:36.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.075915 13235 leader_election.cc:290] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [CANDIDATE]: Term 1 election: Requested vote from peers 
20:03:36.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.076205 13240 raft_consensus.cc:2804] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [term 1 FOLLOWER]: Leader election won for term 1
20:03:36.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.079453 13240 raft_consensus.cc:697] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [term 1 LEADER]: Becoming Leader. State: Replica: dce7824989c247808f97cbfb70742e2c, State: Running, Role: LEADER
20:03:36.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.080683 13240 consensus_queue.cc:237] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [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: "dce7824989c247808f97cbfb70742e2c" member_type: VOTER last_known_addr { host: "127.12.212.254" port: 42391 } }
20:03:36.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.082837 13235 sys_catalog.cc:565] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [sys.catalog]: configured and running, proceeding with master startup.
20:03:36.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.095553 13242 sys_catalog.cc:455] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "dce7824989c247808f97cbfb70742e2c" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "dce7824989c247808f97cbfb70742e2c" member_type: VOTER last_known_addr { host: "127.12.212.254" port: 42391 } } }
20:03:36.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.095755 13241 sys_catalog.cc:455] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [sys.catalog]: SysCatalogTable state changed. Reason: New leader dce7824989c247808f97cbfb70742e2c. Latest consensus state: current_term: 1 leader_uuid: "dce7824989c247808f97cbfb70742e2c" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "dce7824989c247808f97cbfb70742e2c" member_type: VOTER last_known_addr { host: "127.12.212.254" port: 42391 } } }
20:03:36.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.096887 13242 sys_catalog.cc:458] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [sys.catalog]: This master's current role is: LEADER
20:03:36.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.097380 13241 sys_catalog.cc:458] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c [sys.catalog]: This master's current role is: LEADER
20:03:36.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.103060 13250 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
20:03:36.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.115299 13250 catalog_manager.cc:1520] Initializing Kudu cluster ID...
20:03:36.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.130895 13250 catalog_manager.cc:1383] Generated new cluster ID: 8f1677b2a8bd4689bba4e8a3f1951799
20:03:36.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.131145 13250 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
20:03:36.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.156045 13250 catalog_manager.cc:1406] Generated new certificate authority record
20:03:36.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.157745 13250 catalog_manager.cc:1540] Loading token signing keys...
20:03:36.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.174291 13250 catalog_manager.cc:6070] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c: Generated new TSK 0
20:03:36.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.175215 13250 catalog_manager.cc:1550] Initializing in-progress tserver states...
20:03:36.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.12.212.193@KRBTEST.COM; defaulting to no policy
20:03:36.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:36.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.12.212.193@KRBTEST.COM" created.
20:03:36.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:36.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.12.212.193 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:36.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.12.212.193 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:36.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.12.212.193@KRBTEST.COM; defaulting to no policy
20:03:36.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:36.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.12.212.193@KRBTEST.COM" created.
20:03:36.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:36.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.12.212.193 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:36.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.12.212.193 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:36.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.275319 13139 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu
20:03:36.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu
20:03:36.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/wal
20:03:36.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/data
20:03:36.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:36.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:36.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:36.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:36.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:36.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:36.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/logs
20:03:36.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/data/info.pb
20:03:36.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:36.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:36.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:36.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:36.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:36.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:36.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:36.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:36.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:03:36.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:36.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.212.193:0
20:03:36.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.212.193
20:03:36.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.212.193
20:03:36.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:36.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.212.254:42391
20:03:36.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab
20:03:36.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.12.212.193
20:03:36.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
20:03:36.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
20:03:36.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
20:03:36.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
20:03:36.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.212.212:37137
20:03:36.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:36.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:36.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:36.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
20:03:36.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
20:03:36.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
20:03:36.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:36.575961 13263 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
20:03:36.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:36.576505 13263 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:36.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:36.576705 13263 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:36.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:36.577564 13263 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:36.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:36.612723 13263 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:36.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:36.613708 13263 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.12.212.193
20:03:36.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.652001 13263 tablet_server_runner.cc:78] Tablet server non-default flags:
20:03:36.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:36.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.212.212:37137
20:03:36.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:36.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:36.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/data
20:03:36.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/wal
20:03:36.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
20:03:36.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab
20:03:36.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.12.212.193
20:03:36.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:36.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:36.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.212.193:0
20:03:36.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:36.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
20:03:36.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
20:03:36.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
20:03:36.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
20:03:36.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:36.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:36.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/data/info.pb
20:03:36.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.212.193
20:03:36.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:36.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.212.254:42391
20:03:36.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:36.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:36.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:36.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:36.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:36.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.212.193
20:03:36.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/logs
20:03:36.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:36.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:36.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:36.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:03:36.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:36.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
20:03:36.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:03:36.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:23 UTC on e7f111948823
20:03:36.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12779
20:03:36.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:03:36.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.653352 13263 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:36.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:36.654831 13263 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:36.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:36.671597 13269 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
20:03:38.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:38.075435 13268 debug-util.cc:398] Leaking SignalData structure 0x7b080002eee0 after lost signal to thread 13263
20:03:38.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:38.488516 13263 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.814s	user 0.725s	sys 1.000s
20:03:38.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:38.488945 13263 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.815s	user 0.725s	sys 1.000s
20:03:38.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:36.674364 13270 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
20:03:38.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:38.490586 13271 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection timed out after 1816 milliseconds
20:03:38.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:38.491304 13272 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
20:03:38.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.491902 13263 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
20:03:38.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.496186 13263 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:38.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.498840 13263 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:38.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.500622 13263 hybrid_clock.cc:648] HybridClock initialized: now 1783541018500588 us; error 53 us; skew 500 ppm
20:03:38.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.501724 13263 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:03:38.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:38 dist-test-slave-815n krb5kdc[13150](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783541018, etypes {rep=17 tkt=17 ses=17}, kudu/127.12.212.193@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
20:03:38.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.509020 13263 init.cc:377] Logged in from keytab as kudu/127.12.212.193@KRBTEST.COM (short username kudu)
20:03:38.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.514278 13263 webserver.cc:533] Webserver started at http://127.12.212.193:36671/ using document root <none> and password file <none>
20:03:38.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.515105 13263 fs_manager.cc:362] Metadata directory not provided
20:03:38.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.515290 13263 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:38.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.515662 13263 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:38.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.521919 13263 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/data/instance:
20:03:38.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "66a4368f20a14fd9affbe2b33f2dfd95"
20:03:38.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:38 on dist-test-slave-815n"
20:03:38.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.523187 13263 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/wal/instance:
20:03:38.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "66a4368f20a14fd9affbe2b33f2dfd95"
20:03:38.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:38 on dist-test-slave-815n"
20:03:38.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.530912 13263 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.006s	sys 0.002s
20:03:38.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.536788 13280 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:38.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.538115 13263 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.002s
20:03:38.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.538482 13263 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/data,/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/wal
20:03:38.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "66a4368f20a14fd9affbe2b33f2dfd95"
20:03:38.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:38 on dist-test-slave-815n"
20:03:38.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.538923 13263 fs_report.cc:389] FS layout report
20:03:38.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:38.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/wal
20:03:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/wal
20:03:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/data/data
20:03:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:38.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:38.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:38.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:38.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.606891 13263 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:38.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.614032 13263 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
20:03:38.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.614609 13263 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:38.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.617956 13263 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:03:38.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.623340 13263 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:03:38.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.623615 13263 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
20:03:38.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.623951 13263 ts_tablet_manager.cc:616] Registered 0 tablets
20:03:38.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.624171 13263 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
20:03:38.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.773240 13263 rpc_server.cc:307] RPC server started. Bound to: 127.12.212.193:40535
20:03:38.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.773322 13392 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.212.193:40535 every 8 connection(s)
20:03:38.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.776765 13263 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/data/info.pb
20:03:38.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.781661 13139 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu as pid 13263
20:03:38.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.782140 13139 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-0/wal/instance
20:03:38.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:38 dist-test-slave-815n krb5kdc[13150](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783541018, etypes {rep=17 tkt=17 ses=17}, kudu/127.12.212.193@KRBTEST.COM for kudu/127.12.212.254@KRBTEST.COM
20:03:38.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.12.212.194@KRBTEST.COM; defaulting to no policy
20:03:38.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:38.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.12.212.194@KRBTEST.COM" created.
20:03:38.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.815768 13393 heartbeater.cc:344] Connected to a master server at 127.12.212.254:42391
20:03:38.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.816294 13393 heartbeater.cc:461] Registering TS with master...
20:03:38.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.817696 13393 heartbeater.cc:507] Master 127.12.212.254:42391 requested a full tablet report, sending...
20:03:38.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.820829 13200 ts_manager.cc:194] Registered new tserver with Master: 66a4368f20a14fd9affbe2b33f2dfd95 (127.12.212.193:40535)
20:03:38.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.823449 13200 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.12.212.193@KRBTEST.COM'} at 127.12.212.193:43431
20:03:38.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:38.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.12.212.194 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:38.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.12.212.194 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:38.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.12.212.194@KRBTEST.COM; defaulting to no policy
20:03:38.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:38.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.12.212.194@KRBTEST.COM" created.
20:03:38.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:38.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.12.212.194 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:38.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.12.212.194 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:38.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:38.874004 13139 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu
20:03:38.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu
20:03:38.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/wal
20:03:38.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/data
20:03:38.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:38.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:38.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:38.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:38.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/logs
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/data/info.pb
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.212.194:0
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.212.194
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.212.194
20:03:38.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.212.254:42391
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.12.212.194
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.212.212:37137
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
20:03:38.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
20:03:39.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:39.189070 13401 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
20:03:39.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:39.189791 13401 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:39.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:39.190160 13401 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:39.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:39.190913 13401 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:39.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:39.223810 13401 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:39.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:39.224933 13401 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.12.212.194
20:03:39.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:39.262633 13401 tablet_server_runner.cc:78] Tablet server non-default flags:
20:03:39.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:39.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.212.212:37137
20:03:39.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:39.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:39.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/data
20:03:39.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/wal
20:03:39.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
20:03:39.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab
20:03:39.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.12.212.194
20:03:39.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:39.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:39.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.212.194:0
20:03:39.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:39.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
20:03:39.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
20:03:39.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
20:03:39.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
20:03:39.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:39.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:39.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/data/info.pb
20:03:39.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.212.194
20:03:39.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:39.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.212.254:42391
20:03:39.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:39.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:39.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.212.194
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/logs
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:03:39.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:23 UTC on e7f111948823
20:03:39.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12779
20:03:39.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:03:39.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:39.264395 13401 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:39.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:39.265966 13401 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:39.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:39.278810 13407 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
20:03:39.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:39.827801 13393 heartbeater.cc:499] Master 127.12.212.254:42391 was elected leader, sending a full tablet report...
20:03:41.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:40.682874 13406 debug-util.cc:398] Leaking SignalData structure 0x7b080002eee0 after lost signal to thread 13401
20:03:41.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.049517 13406 kernel_stack_watchdog.cc:198] Thread 13401 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 400ms:
20:03:41.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
20:03:41.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
20:03:41.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
20:03:41.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
20:03:41.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:39.281018 13408 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
20:03:41.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.050206 13401 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.770s	user 0.000s	sys 0.002s
20:03:41.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.050544 13401 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.771s	user 0.000s	sys 0.002s
20:03:41.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.054643 13409 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1768 milliseconds
20:03:41.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.055920 13410 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
20:03:41.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.055984 13401 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
20:03:41.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.057090 13401 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:41.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.059103 13401 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:41.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.060453 13401 hybrid_clock.cc:648] HybridClock initialized: now 1783541021060423 us; error 42 us; skew 500 ppm
20:03:41.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.061287 13401 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:03:41.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:41 dist-test-slave-815n krb5kdc[13150](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783541021, etypes {rep=17 tkt=17 ses=17}, kudu/127.12.212.194@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
20:03:41.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.067629 13401 init.cc:377] Logged in from keytab as kudu/127.12.212.194@KRBTEST.COM (short username kudu)
20:03:41.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.073266 13401 webserver.cc:533] Webserver started at http://127.12.212.194:39497/ using document root <none> and password file <none>
20:03:41.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.074255 13401 fs_manager.cc:362] Metadata directory not provided
20:03:41.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.074512 13401 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:41.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.075083 13401 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:41.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.079355 13401 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/data/instance:
20:03:41.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e06878ac924a4fe48be52a6def77f970"
20:03:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:41 on dist-test-slave-815n"
20:03:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.080518 13401 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/wal/instance:
20:03:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e06878ac924a4fe48be52a6def77f970"
20:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:41 on dist-test-slave-815n"
20:03:41.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.087598 13401 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.006s	sys 0.003s
20:03:41.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.092900 13418 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:41.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.094136 13401 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.002s
20:03:41.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.094511 13401 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/data,/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/wal
20:03:41.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e06878ac924a4fe48be52a6def77f970"
20:03:41.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:41 on dist-test-slave-815n"
20:03:41.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.094877 13401 fs_report.cc:389] FS layout report
20:03:41.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:41.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/wal
20:03:41.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/wal
20:03:41.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/data/data
20:03:41.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:41.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:41.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:41.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:41.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:41.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:41.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:41.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:41.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:41.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:41.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:41.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.156988 13401 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:41.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.166064 13401 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
20:03:41.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.166569 13401 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:41.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.169247 13401 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:03:41.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.173175 13401 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:03:41.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.173420 13401 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
20:03:41.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.173717 13401 ts_tablet_manager.cc:616] Registered 0 tablets
20:03:41.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.173919 13401 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
20:03:41.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.305881 13401 rpc_server.cc:307] RPC server started. Bound to: 127.12.212.194:40729
20:03:41.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.305987 13530 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.212.194:40729 every 8 connection(s)
20:03:41.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.308573 13401 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/data/info.pb
20:03:41.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.311007 13139 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu as pid 13401
20:03:41.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.311480 13139 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/wal/instance
20:03:41.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:41 dist-test-slave-815n krb5kdc[13150](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783541021, etypes {rep=17 tkt=17 ses=17}, kudu/127.12.212.194@KRBTEST.COM for kudu/127.12.212.254@KRBTEST.COM
20:03:41.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.12.212.195@KRBTEST.COM; defaulting to no policy
20:03:41.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:41.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.12.212.195@KRBTEST.COM" created.
20:03:41.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.343475 13531 heartbeater.cc:344] Connected to a master server at 127.12.212.254:42391
20:03:41.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.343948 13531 heartbeater.cc:461] Registering TS with master...
20:03:41.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.345028 13531 heartbeater.cc:507] Master 127.12.212.254:42391 requested a full tablet report, sending...
20:03:41.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.347501 13200 ts_manager.cc:194] Registered new tserver with Master: e06878ac924a4fe48be52a6def77f970 (127.12.212.194:40729)
20:03:41.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.349421 13200 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.12.212.194@KRBTEST.COM'} at 127.12.212.194:49719
20:03:41.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:41.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.12.212.195 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:41.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.12.212.195 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:41.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.12.212.195@KRBTEST.COM; defaulting to no policy
20:03:41.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:41.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.12.212.195@KRBTEST.COM" created.
20:03:41.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
20:03:41.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.12.212.195 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:41.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.12.212.195 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab.
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.397846 13139 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/wal
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/data
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/logs
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/data/info.pb
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:41.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.212.195:0
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.212.195
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.212.195
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.212.254:42391
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.12.212.195
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
20:03:41.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.212.212:37137
20:03:41.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:41.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:41.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:41.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
20:03:41.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
20:03:41.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
20:03:41.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.694401 13539 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
20:03:41.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.694918 13539 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:41.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.695173 13539 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:41.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.695734 13539 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:41.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.727367 13539 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:41.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.728258 13539 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.12.212.195
20:03:41.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.754334 13389 debug-util.cc:398] Leaking SignalData structure 0x7b08000ae060 after lost signal to thread 13264
20:03:41.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.755108 13389 debug-util.cc:398] Leaking SignalData structure 0x7b08000b4540 after lost signal to thread 13392
20:03:41.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.765044 13539 tablet_server_runner.cc:78] Tablet server non-default flags:
20:03:41.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:41.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.212.212:37137
20:03:41.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:41.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:41.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/data
20:03:41.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/wal
20:03:41.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
20:03:41.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kudu.keytab
20:03:41.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.12.212.195
20:03:41.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:41.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:41.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.212.195:0
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/data/info.pb
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.212.195
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.212.254:42391
20:03:41.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.212.195
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/logs
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
20:03:41.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
20:03:41.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:23 UTC on e7f111948823
20:03:41.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12779
20:03:41.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
20:03:41.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.766788 13539 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:41.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:41.768357 13539 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:41.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.785003 13545 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
20:03:42.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:42.352715 13531 heartbeater.cc:499] Master 127.12.212.254:42391 was elected leader, sending a full tablet report...
20:03:43.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:43.183681 13544 debug-util.cc:398] Leaking SignalData structure 0x7b080002eee0 after lost signal to thread 13539
20:03:43.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:43.599278 13544 kernel_stack_watchdog.cc:198] Thread 13539 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 396ms:
20:03:43.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
20:03:43.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
20:03:43.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
20:03:43.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
20:03:43.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:43.600351 13548 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
20:03:43.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:43.600595 13539 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.814s	user 0.496s	sys 1.139s
20:03:43.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:43.601020 13539 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.816s	user 0.496s	sys 1.139s
20:03:43.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:41.785897 13546 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
20:03:43.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:43.605914 13547 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1816 milliseconds
20:03:43.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.605914 13539 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
20:03:43.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.607184 13539 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:43.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.609375 13539 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:43.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.610822 13539 hybrid_clock.cc:648] HybridClock initialized: now 1783541023610762 us; error 60 us; skew 500 ppm
20:03:43.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.611686 13539 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
20:03:43.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:43 dist-test-slave-815n krb5kdc[13150](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783541023, etypes {rep=17 tkt=17 ses=17}, kudu/127.12.212.195@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
20:03:43.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.618137 13539 init.cc:377] Logged in from keytab as kudu/127.12.212.195@KRBTEST.COM (short username kudu)
20:03:43.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.623843 13539 webserver.cc:533] Webserver started at http://127.12.212.195:46709/ using document root <none> and password file <none>
20:03:43.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.625114 13539 fs_manager.cc:362] Metadata directory not provided
20:03:43.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.625417 13539 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:43.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.625993 13539 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:43.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.631749 13539 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/data/instance:
20:03:43.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "00495da177c946ff9b82242216b2c960"
20:03:43.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:43 on dist-test-slave-815n"
20:03:43.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.632778 13539 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/wal/instance:
20:03:43.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "00495da177c946ff9b82242216b2c960"
20:03:43.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:43 on dist-test-slave-815n"
20:03:43.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.640229 13539 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.007s	sys 0.003s
20:03:43.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.646082 13557 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:43.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.647187 13539 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.002s
20:03:43.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.647473 13539 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/data,/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/wal
20:03:43.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "00495da177c946ff9b82242216b2c960"
20:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:43 on dist-test-slave-815n"
20:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.647778 13539 fs_report.cc:389] FS layout report
20:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/wal
20:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/wal
20:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/data/data
20:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:43.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:43.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:43.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:43.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:43.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:43.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:43.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:43.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:43.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.697456 13539 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:43.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.702719 13539 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
20:03:43.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.703106 13539 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:43.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.705709 13539 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:03:43.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.710137 13539 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:03:43.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.710325 13539 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
20:03:43.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.710507 13539 ts_tablet_manager.cc:616] Registered 0 tablets
20:03:43.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.710628 13539 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
20:03:43.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.887921 13539 rpc_server.cc:307] RPC server started. Bound to: 127.12.212.195:36971
20:03:43.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.888036 13669 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.212.195:36971 every 8 connection(s)
20:03:43.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.890761 13539 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/data/info.pb
20:03:43.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.899458 13139 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu as pid 13539
20:03:43.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.900156 13139 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/wal/instance
20:03:43.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:43 dist-test-slave-815n krb5kdc[13150](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783541023, etypes {rep=17 tkt=17 ses=17}, kudu/127.12.212.195@KRBTEST.COM for kudu/127.12.212.254@KRBTEST.COM
20:03:43.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.928073 13670 heartbeater.cc:344] Connected to a master server at 127.12.212.254:42391
20:03:43.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.928449 13670 heartbeater.cc:461] Registering TS with master...
20:03:43.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.929376 13670 heartbeater.cc:507] Master 127.12.212.254:42391 requested a full tablet report, sending...
20:03:43.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.931442 13200 ts_manager.cc:194] Registered new tserver with Master: 00495da177c946ff9b82242216b2c960 (127.12.212.195:36971)
20:03:43.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.932570 13200 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.12.212.195@KRBTEST.COM'} at 127.12.212.195:59221
20:03:43.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:43.937150 13139 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
20:03:43.954 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
20:03:43.955 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

20:03:43.962 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

20:03:43.963 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

20:03:43.971 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.12.212.254"
      port: 42391
    }
    bound_http_address {
      host: "127.12.212.254"
      port: 37565
    }
  }
}

20:03:43.974 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

20:03:43.977 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.12.212.193"
      port: 40535
    }
    bound_http_address {
      host: "127.12.212.193"
      port: 36671
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.12.212.194"
      port: 40729
    }
    bound_http_address {
      host: "127.12.212.194"
      port: 39497
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.12.212.195"
      port: 36971
    }
    bound_http_address {
      host: "127.12.212.195"
      port: 46709
    }
  }
}

20:03:43.977 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
20:03:44.203 [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.doOneAttemptAndReport(RetryRule.java:184)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:244)
	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)
20:03:44.232 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/krb5kdc/krb5cc
20:03:44.282 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
20:03:44.407 [DEBUG - main] (Connection.java:748) [peer master-127.12.212.254:42391(127.12.212.254:42391)] connecting to peer
20:03:44.502 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.12.212.254:42391(127.12.212.254:42391)] Successfully connected to peer
20:03:44.625 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism GSSAPI chosen for peer 127.12.212.254
20:03:44.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 20:03:44 dist-test-slave-815n krb5kdc[13150](info): TGS_REQ (1 etypes {17}) 127.0.0.1: ISSUE: authtime 1783541014, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.12.212.254@KRBTEST.COM
20:03:44.878 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0x4872e8fc, L:/127.0.0.1:41182 - R:/127.12.212.254:42391] using SASL/GSSAPI
20:03:44.924 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
20:03:44.926 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTabletServers, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=562), Traces: [0ms] refreshing cache from master, [26ms] Sub RPC ConnectToMaster: sending RPC to server master-127.12.212.254:42391, [531ms] Sub RPC ConnectToMaster: received response from server master-127.12.212.254:42391: OK, deferred=null) after lookup
20:03:44.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:44.936591 13670 heartbeater.cc:499] Master 127.12.212.254:42391 was elected leader, sending a full tablet report...
20:03:44.948 [DEBUG - main] (Connection.java:575) [peer master-127.12.212.254:42391(127.12.212.254:42391)] disconnecting while in state READY
20:03:44.954 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.12.212.254:42391(127.12.212.254:42391)] handling channelInactive
20:03:44.955 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.12.212.254:42391(127.12.212.254:42391)] cleaning up while in state READY due to: connection closed
20:03:44.955 [INFO - kudu-nio-0] (AsyncKuduClient.java:2355) Invalidating location master-127.12.212.254:42391(127.12.212.254:42391) for tablet Kudu Master: connection closed
20:03:44.966 [DEBUG - pool-2-thread-1] (Connection.java:748) [peer master-127.12.212.254:42391(127.12.212.254:42391)] connecting to peer
20:03:44.969 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.12.212.254:42391(127.12.212.254:42391)] Successfully connected to peer
20:03:45.031 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0xabdd15d5, L:/127.0.0.1:41184 - R:/127.12.212.254:42391] using TOKEN/null
20:03:45.036 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
20:03:45.037 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=Kudu Master, attempt=2, TimeoutTracker(timeout=50000, elapsed=87), Traces: [0ms] sending RPC to server master-127.12.212.254:42391, [6ms] received response from server master-127.12.212.254:42391: Network error: connection closed, [6ms] delaying RPC due to: Network error: connection closed, [16ms] refreshing cache from master, [17ms] Sub RPC ConnectToMaster: sending RPC to server master-127.12.212.254:42391, [87ms] Sub RPC ConnectToMaster: received response from server master-127.12.212.254:42391: OK, deferred=Deferred@1155201534(state=PENDING, result=null, callback=wakeup thread main, errback=wakeup thread main)) after lookup
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.097214 13200 catalog_manager.cc:2283] Servicing CreateTable request from {username='test-admin'} at 127.0.0.1:41184:
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "TestAuthnTokenReacquireOpen-table"
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
20:03:45.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:03:45.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
20:03:45.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
20:03:45.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
20:03:45.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
20:03:45.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
20:03:45.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
20:03:45.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:03:45.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
20:03:45.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:45.120891 13200 catalog_manager.cc:7077] 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.
20:03:45.164 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 475654c190f24deaa26d64be6484bd3f
20:03:45.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.200053 13328 tablet_service.cc:1511] Processing CreateTablet for tablet b69f231e1f634fedbf5a0ce19ddc3403 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=475654c190f24deaa26d64be6484bd3f]), partition=RANGE (key) PARTITION UNBOUNDED
20:03:45.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.202363 13328 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet b69f231e1f634fedbf5a0ce19ddc3403. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:45.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.207093 13466 tablet_service.cc:1511] Processing CreateTablet for tablet b69f231e1f634fedbf5a0ce19ddc3403 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=475654c190f24deaa26d64be6484bd3f]), partition=RANGE (key) PARTITION UNBOUNDED
20:03:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.208901 13466 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet b69f231e1f634fedbf5a0ce19ddc3403. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:45.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.208707 13605 tablet_service.cc:1511] Processing CreateTablet for tablet b69f231e1f634fedbf5a0ce19ddc3403 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=475654c190f24deaa26d64be6484bd3f]), partition=RANGE (key) PARTITION UNBOUNDED
20:03:45.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.210429 13605 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet b69f231e1f634fedbf5a0ce19ddc3403. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:45.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.244432 13690 tablet_bootstrap.cc:492] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95: Bootstrap starting.
20:03:45.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.245710 13691 tablet_bootstrap.cc:492] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: Bootstrap starting.
20:03:45.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.252542 13690 tablet_bootstrap.cc:654] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95: Neither blocks nor log segments found. Creating new log.
20:03:45.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.253300 13692 tablet_bootstrap.cc:492] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: Bootstrap starting.
20:03:45.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.255141 13690 log.cc:826] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95: Log is configured to *not* fsync() on all Append() calls
20:03:45.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.256453 13691 tablet_bootstrap.cc:654] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: Neither blocks nor log segments found. Creating new log.
20:03:45.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.259227 13691 log.cc:826] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: Log is configured to *not* fsync() on all Append() calls
20:03:45.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.264108 13692 tablet_bootstrap.cc:654] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: Neither blocks nor log segments found. Creating new log.
20:03:45.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.267120 13692 log.cc:826] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: Log is configured to *not* fsync() on all Append() calls
20:03:45.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.270079 13690 tablet_bootstrap.cc:492] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95: No bootstrap required, opened a new log
20:03:45.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.270746 13690 ts_tablet_manager.cc:1403] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95: Time spent bootstrapping tablet: real 0.028s	user 0.017s	sys 0.007s
20:03:45.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.272714 13691 tablet_bootstrap.cc:492] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: No bootstrap required, opened a new log
20:03:45.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.273336 13691 ts_tablet_manager.cc:1403] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: Time spent bootstrapping tablet: real 0.028s	user 0.011s	sys 0.008s
20:03:45.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.294540 13692 tablet_bootstrap.cc:492] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: No bootstrap required, opened a new log
20:03:45.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.295375 13692 ts_tablet_manager.cc:1403] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: Time spent bootstrapping tablet: real 0.043s	user 0.020s	sys 0.013s
20:03:45.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.302296 13690 raft_consensus.cc:359] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66a4368f20a14fd9affbe2b33f2dfd95" member_type: VOTER last_known_addr { host: "127.12.212.193" port: 40535 } } peers { permanent_uuid: "e06878ac924a4fe48be52a6def77f970" member_type: VOTER last_known_addr { host: "127.12.212.194" port: 40729 } } peers { permanent_uuid: "00495da177c946ff9b82242216b2c960" member_type: VOTER last_known_addr { host: "127.12.212.195" port: 36971 } }
20:03:45.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.303417 13690 raft_consensus.cc:385] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:45.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.303922 13690 raft_consensus.cc:740] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 66a4368f20a14fd9affbe2b33f2dfd95, State: Initialized, Role: FOLLOWER
20:03:45.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.305056 13690 consensus_queue.cc:260] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95 [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: "66a4368f20a14fd9affbe2b33f2dfd95" member_type: VOTER last_known_addr { host: "127.12.212.193" port: 40535 } } peers { permanent_uuid: "e06878ac924a4fe48be52a6def77f970" member_type: VOTER last_known_addr { host: "127.12.212.194" port: 40729 } } peers { permanent_uuid: "00495da177c946ff9b82242216b2c960" member_type: VOTER last_known_addr { host: "127.12.212.195" port: 36971 } }
20:03:45.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.305713 13691 raft_consensus.cc:359] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66a4368f20a14fd9affbe2b33f2dfd95" member_type: VOTER last_known_addr { host: "127.12.212.193" port: 40535 } } peers { permanent_uuid: "e06878ac924a4fe48be52a6def77f970" member_type: VOTER last_known_addr { host: "127.12.212.194" port: 40729 } } peers { permanent_uuid: "00495da177c946ff9b82242216b2c960" member_type: VOTER last_known_addr { host: "127.12.212.195" port: 36971 } }
20:03:45.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.307024 13691 raft_consensus.cc:385] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:45.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.307331 13691 raft_consensus.cc:740] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 00495da177c946ff9b82242216b2c960, State: Initialized, Role: FOLLOWER
20:03:45.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.308266 13691 consensus_queue.cc:260] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960 [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: "66a4368f20a14fd9affbe2b33f2dfd95" member_type: VOTER last_known_addr { host: "127.12.212.193" port: 40535 } } peers { permanent_uuid: "e06878ac924a4fe48be52a6def77f970" member_type: VOTER last_known_addr { host: "127.12.212.194" port: 40729 } } peers { permanent_uuid: "00495da177c946ff9b82242216b2c960" member_type: VOTER last_known_addr { host: "127.12.212.195" port: 36971 } }
20:03:45.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.318346 13691 ts_tablet_manager.cc:1434] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: Time spent starting tablet: real 0.045s	user 0.030s	sys 0.010s
20:03:45.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.347442 13690 ts_tablet_manager.cc:1434] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95: Time spent starting tablet: real 0.076s	user 0.039s	sys 0.031s
20:03:45.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.351763 13692 raft_consensus.cc:359] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66a4368f20a14fd9affbe2b33f2dfd95" member_type: VOTER last_known_addr { host: "127.12.212.193" port: 40535 } } peers { permanent_uuid: "e06878ac924a4fe48be52a6def77f970" member_type: VOTER last_known_addr { host: "127.12.212.194" port: 40729 } } peers { permanent_uuid: "00495da177c946ff9b82242216b2c960" member_type: VOTER last_known_addr { host: "127.12.212.195" port: 36971 } }
20:03:45.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.352982 13692 raft_consensus.cc:385] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:45.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.353560 13692 raft_consensus.cc:740] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e06878ac924a4fe48be52a6def77f970, State: Initialized, Role: FOLLOWER
20:03:45.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.354790 13692 consensus_queue.cc:260] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [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: "66a4368f20a14fd9affbe2b33f2dfd95" member_type: VOTER last_known_addr { host: "127.12.212.193" port: 40535 } } peers { permanent_uuid: "e06878ac924a4fe48be52a6def77f970" member_type: VOTER last_known_addr { host: "127.12.212.194" port: 40729 } } peers { permanent_uuid: "00495da177c946ff9b82242216b2c960" member_type: VOTER last_known_addr { host: "127.12.212.195" port: 36971 } }
20:03:45.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.367707 13692 ts_tablet_manager.cc:1434] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: Time spent starting tablet: real 0.072s	user 0.032s	sys 0.009s
20:03:45.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.381764 13698 raft_consensus.cc:493] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
20:03:45.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.382339 13698 raft_consensus.cc:515] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66a4368f20a14fd9affbe2b33f2dfd95" member_type: VOTER last_known_addr { host: "127.12.212.193" port: 40535 } } peers { permanent_uuid: "e06878ac924a4fe48be52a6def77f970" member_type: VOTER last_known_addr { host: "127.12.212.194" port: 40729 } } peers { permanent_uuid: "00495da177c946ff9b82242216b2c960" member_type: VOTER last_known_addr { host: "127.12.212.195" port: 36971 } }
20:03:45.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.387003 13698 leader_election.cc:290] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 66a4368f20a14fd9affbe2b33f2dfd95 (127.12.212.193:40535), 00495da177c946ff9b82242216b2c960 (127.12.212.195:36971)
20:03:45.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:45.397068 13671 tablet.cc:2406] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:03:45.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.399338 13625 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b69f231e1f634fedbf5a0ce19ddc3403" candidate_uuid: "e06878ac924a4fe48be52a6def77f970" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "00495da177c946ff9b82242216b2c960" is_pre_election: true
20:03:45.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.400177 13625 raft_consensus.cc:2468] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate e06878ac924a4fe48be52a6def77f970 in term 0.
20:03:45.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.400363 13348 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b69f231e1f634fedbf5a0ce19ddc3403" candidate_uuid: "e06878ac924a4fe48be52a6def77f970" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "66a4368f20a14fd9affbe2b33f2dfd95" is_pre_election: true
20:03:45.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.401235 13348 raft_consensus.cc:2468] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate e06878ac924a4fe48be52a6def77f970 in term 0.
20:03:45.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.401876 13420 leader_election.cc:304] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [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: 00495da177c946ff9b82242216b2c960, e06878ac924a4fe48be52a6def77f970; no voters: 
20:03:45.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.402729 13698 raft_consensus.cc:2804] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 0 FOLLOWER]: Leader pre-election won for term 1
20:03:45.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.403045 13698 raft_consensus.cc:493] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
20:03:45.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.403259 13698 raft_consensus.cc:3060] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 0 FOLLOWER]: Advancing to term 1
20:03:45.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.407277 13698 raft_consensus.cc:515] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66a4368f20a14fd9affbe2b33f2dfd95" member_type: VOTER last_known_addr { host: "127.12.212.193" port: 40535 } } peers { permanent_uuid: "e06878ac924a4fe48be52a6def77f970" member_type: VOTER last_known_addr { host: "127.12.212.194" port: 40729 } } peers { permanent_uuid: "00495da177c946ff9b82242216b2c960" member_type: VOTER last_known_addr { host: "127.12.212.195" port: 36971 } }
20:03:45.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.408725 13698 leader_election.cc:290] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [CANDIDATE]: Term 1 election: Requested vote from peers 66a4368f20a14fd9affbe2b33f2dfd95 (127.12.212.193:40535), 00495da177c946ff9b82242216b2c960 (127.12.212.195:36971)
20:03:45.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.409947 13348 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b69f231e1f634fedbf5a0ce19ddc3403" candidate_uuid: "e06878ac924a4fe48be52a6def77f970" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "66a4368f20a14fd9affbe2b33f2dfd95"
20:03:45.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.410122 13625 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "b69f231e1f634fedbf5a0ce19ddc3403" candidate_uuid: "e06878ac924a4fe48be52a6def77f970" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "00495da177c946ff9b82242216b2c960"
20:03:45.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.410432 13348 raft_consensus.cc:3060] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95 [term 0 FOLLOWER]: Advancing to term 1
20:03:45.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.410578 13625 raft_consensus.cc:3060] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960 [term 0 FOLLOWER]: Advancing to term 1
20:03:45.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.415035 13348 raft_consensus.cc:2468] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate e06878ac924a4fe48be52a6def77f970 in term 1.
20:03:45.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.415987 13422 leader_election.cc:304] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [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: 66a4368f20a14fd9affbe2b33f2dfd95, e06878ac924a4fe48be52a6def77f970; no voters: 
20:03:45.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.416958 13698 raft_consensus.cc:2804] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 1 FOLLOWER]: Leader election won for term 1
20:03:45.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.417016 13625 raft_consensus.cc:2468] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate e06878ac924a4fe48be52a6def77f970 in term 1.
20:03:45.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.421887 13698 raft_consensus.cc:697] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 1 LEADER]: Becoming Leader. State: Replica: e06878ac924a4fe48be52a6def77f970, State: Running, Role: LEADER
20:03:45.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.422887 13698 consensus_queue.cc:237] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [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: "66a4368f20a14fd9affbe2b33f2dfd95" member_type: VOTER last_known_addr { host: "127.12.212.193" port: 40535 } } peers { permanent_uuid: "e06878ac924a4fe48be52a6def77f970" member_type: VOTER last_known_addr { host: "127.12.212.194" port: 40729 } } peers { permanent_uuid: "00495da177c946ff9b82242216b2c960" member_type: VOTER last_known_addr { host: "127.12.212.195" port: 36971 } }
20:03:45.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.436021 13200 catalog_manager.cc:5697] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 reported cstate change: term changed from 0 to 1, leader changed from <none> to e06878ac924a4fe48be52a6def77f970 (127.12.212.194). New cstate: current_term: 1 leader_uuid: "e06878ac924a4fe48be52a6def77f970" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66a4368f20a14fd9affbe2b33f2dfd95" member_type: VOTER last_known_addr { host: "127.12.212.193" port: 40535 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "e06878ac924a4fe48be52a6def77f970" member_type: VOTER last_known_addr { host: "127.12.212.194" port: 40729 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "00495da177c946ff9b82242216b2c960" member_type: VOTER last_known_addr { host: "127.12.212.195" port: 36971 } health_report { overall_health: UNKNOWN } } }
20:03:45.453 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 475654c190f24deaa26d64be6484bd3f
20:03:45.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:45.544762 13394 tablet.cc:2406] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:03:45.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:45.567340 13532 tablet.cc:2406] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:03:45.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.831893 13698 consensus_queue.cc:1048] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [LEADER]: Connected to new peer: Peer: permanent_uuid: "00495da177c946ff9b82242216b2c960" member_type: VOTER last_known_addr { host: "127.12.212.195" port: 36971 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
20:03:45.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:45.846760 13701 consensus_queue.cc:1048] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [LEADER]: Connected to new peer: Peer: permanent_uuid: "66a4368f20a14fd9affbe2b33f2dfd95" member_type: VOTER last_known_addr { host: "127.12.212.193" port: 40535 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
20:03:46.458 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 475654c190f24deaa26d64be6484bd3f
20:03:46.480 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet b69f231e1f634fedbf5a0ce19ddc3403 for table 'TestAuthnTokenReacquireOpen-table' with partition [<start>, <end>)
20:03:46.485 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299995, tablet=b69f231e1f634fedbf5a0ce19ddc3403@[00495da177c946ff9b82242216b2c960(127.12.212.195:36971),66a4368f20a14fd9affbe2b33f2dfd95(127.12.212.193:40535),e06878ac924a4fe48be52a6def77f970(127.12.212.194:40729)[L]]}]
20:03:46.492 [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=14), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.12.212.254:42391, [8ms] Sub RPC GetTableLocations: received response from server master-127.12.212.254:42391: OK, deferred=null)) after lookup
20:03:46.501 [DEBUG - kudu-nio-1] (Connection.java:748) [peer e06878ac924a4fe48be52a6def77f970(127.12.212.194:40729)] connecting to peer
20:03:46.504 [DEBUG - kudu-nio-2] (Connection.java:757) [peer e06878ac924a4fe48be52a6def77f970(127.12.212.194:40729)] Successfully connected to peer
20:03:46.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:46.548707 13713 negotiation.cc:343] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:58860: token expired
20:03:46.553 [DEBUG - kudu-nio-2] (Negotiator.java:351) peer /127.12.212.194:40729 sent connection negotiation error: Not authorized: token expired
20:03:46.555 [DEBUG - kudu-nio-2] (Connection.java:239) [peer e06878ac924a4fe48be52a6def77f970(127.12.212.194:40729)] handling channelInactive
20:03:46.555 [DEBUG - kudu-nio-2] (Connection.java:709) [peer e06878ac924a4fe48be52a6def77f970(127.12.212.194:40729)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
20:03:46.556 [DEBUG - kudu-nio-2] (Connection.java:748) [peer master-127.12.212.254:42391(127.12.212.254:42391)] connecting to peer
20:03:46.559 [DEBUG - kudu-nio-3] (Connection.java:757) [peer master-127.12.212.254:42391(127.12.212.254:42391)] Successfully connected to peer
20:03:46.568 [DEBUG - kudu-nio-3] (Negotiator.java:528) SASL mechanism GSSAPI chosen for peer 127.12.212.254
20:03:46.613 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0xe9fd3492, L:/127.0.0.1:41192 - R:/127.12.212.254:42391] using SASL/GSSAPI
20:03:46.617 [INFO - kudu-nio-3] (AsyncKuduClient.java:516) connect to master: received a new authn token
20:03:46.618 [DEBUG - kudu-nio-3] (Connection.java:748) [peer e06878ac924a4fe48be52a6def77f970(127.12.212.194:40729)] connecting to peer
20:03:46.623 [DEBUG - kudu-nio-4] (Connection.java:757) [peer e06878ac924a4fe48be52a6def77f970(127.12.212.194:40729)] Successfully connected to peer
20:03:46.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:46.648844 13713 fault_injection.cc:43] FAULT INJECTION ENABLED!
20:03:46.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:46.649106 13713 fault_injection.cc:44] THIS SERVER MAY CRASH!
20:03:46.651 [DEBUG - kudu-nio-4] (Negotiator.java:918) Authenticated connection [id: 0xc9325b96, L:/127.0.0.1:58876 - R:/127.12.212.194:40729] using TOKEN/null
20:03:46.688 [DEBUG - kudu-nio-4] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 0 rows, more = false) for scanner KuduScanner(table=TestAuthnTokenReacquireOpen-table, tablet=b69f231e1f634fedbf5a0ce19ddc3403, scannerId=null, scanRequestTimeout=60000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:46.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.703538 13200 catalog_manager.cc:2533] Servicing SoftDeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:41192:
20:03:46.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
20:03:46.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.704162 13200 catalog_manager.cc:2781] Servicing DeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:41192:
20:03:46.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
20:03:46.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.717360 13200 catalog_manager.cc:5984] T 00000000000000000000000000000000 P dce7824989c247808f97cbfb70742e2c: Sending DeleteTablet for 3 replicas of tablet b69f231e1f634fedbf5a0ce19ddc3403
20:03:46.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.719905 13466 tablet_service.cc:1558] Processing DeleteTablet for tablet b69f231e1f634fedbf5a0ce19ddc3403 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 20:03:46 UTC) from {username='kudu', principal='kudu/127.12.212.254@KRBTEST.COM'} at 127.0.0.1:58856
20:03:46.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.720935 13328 tablet_service.cc:1558] Processing DeleteTablet for tablet b69f231e1f634fedbf5a0ce19ddc3403 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 20:03:46 UTC) from {username='kudu', principal='kudu/127.12.212.254@KRBTEST.COM'} at 127.0.0.1:51062
20:03:46.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.721325 13605 tablet_service.cc:1558] Processing DeleteTablet for tablet b69f231e1f634fedbf5a0ce19ddc3403 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 20:03:46 UTC) from {username='kudu', principal='kudu/127.12.212.254@KRBTEST.COM'} at 127.0.0.1:45706
20:03:46.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.728946 13724 tablet_replica.cc:333] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: stopping tablet replica
20:03:46.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.733465 13726 tablet_replica.cc:333] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: stopping tablet replica
20:03:46.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.734544 13726 raft_consensus.cc:2243] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960 [term 1 FOLLOWER]: Raft consensus shutting down.
20:03:46.735 [DEBUG - main] (Connection.java:575) [peer e06878ac924a4fe48be52a6def77f970(127.12.212.194:40729)] disconnecting while in state READY
20:03:46.736 [DEBUG - main] (Connection.java:575) [peer master-127.12.212.254:42391(127.12.212.254:42391)] disconnecting while in state READY
20:03:46.737 [DEBUG - kudu-nio-4] (Connection.java:239) [peer e06878ac924a4fe48be52a6def77f970(127.12.212.194:40729)] handling channelInactive
20:03:46.737 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.12.212.254:42391(127.12.212.254:42391)] handling channelInactive
20:03:46.737 [DEBUG - kudu-nio-4] (Connection.java:709) [peer e06878ac924a4fe48be52a6def77f970(127.12.212.194:40729)] cleaning up while in state READY due to: connection closed
20:03:46.737 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.12.212.254:42391(127.12.212.254:42391)] cleaning up while in state READY due to: connection closed
20:03:46.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.736799 13726 raft_consensus.cc:2272] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960 [term 1 FOLLOWER]: Raft consensus is shut down!
20:03:46.738 [DEBUG - main] (Connection.java:575) [peer master-127.12.212.254:42391(127.12.212.254:42391)] disconnecting while in state READY
20:03:46.740 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
20:03:46.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.740028 13725 tablet_replica.cc:333] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95: stopping tablet replica
20:03:46.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.740648 13724 raft_consensus.cc:2243] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 1 LEADER]: Raft consensus shutting down.
20:03:46.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.742686 13724 raft_consensus.cc:2272] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970 [term 1 FOLLOWER]: Raft consensus is shut down!
20:03:46.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.744606 13725 raft_consensus.cc:2243] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95 [term 1 FOLLOWER]: Raft consensus shutting down.
20:03:46.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.746306 13724 ts_tablet_manager.cc:1916] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: Deleting tablet data with delete state TABLET_DATA_DELETED
20:03:46.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.746820 13726 ts_tablet_manager.cc:1916] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: Deleting tablet data with delete state TABLET_DATA_DELETED
20:03:46.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.747608 13725 raft_consensus.cc:2272] T b69f231e1f634fedbf5a0ce19ddc3403 P 66a4368f20a14fd9affbe2b33f2dfd95 [term 1 FOLLOWER]: Raft consensus is shut down!
20:03:46.754 [DEBUG - kudu-nio-3] (Connection.java:239) [peer master-127.12.212.254:42391(127.12.212.254:42391)] handling channelInactive
20:03:46.754 [DEBUG - kudu-nio-3] (Connection.java:709) [peer master-127.12.212.254:42391(127.12.212.254:42391)] cleaning up while in state READY due to: connection closed
20:03:46.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.754469 13139 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu with pid 13263
20:03:46.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.757936 13724 ts_tablet_manager.cc:1929] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
20:03:46.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.758517 13724 log.cc:1199] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: Deleting WAL directory at /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-1/wal/wals/b69f231e1f634fedbf5a0ce19ddc3403
20:03:46.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.759498 13724 ts_tablet_manager.cc:1950] T b69f231e1f634fedbf5a0ce19ddc3403 P e06878ac924a4fe48be52a6def77f970: Deleting consensus metadata
20:03:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.763082 13184 catalog_manager.cc:5028] TS e06878ac924a4fe48be52a6def77f970 (127.12.212.194:40729): tablet b69f231e1f634fedbf5a0ce19ddc3403 (table TestAuthnTokenReacquireOpen-table [id=475654c190f24deaa26d64be6484bd3f]) successfully deleted
20:03:46.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.765884 13726 ts_tablet_manager.cc:1929] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
20:03:46.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.766292 13726 log.cc:1199] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: Deleting WAL directory at /tmp/dist-test-taskxDOXSZ/test-tmp/mini-kudu-cluster15150575942076280886/ts-2/wal/wals/b69f231e1f634fedbf5a0ce19ddc3403
20:03:46.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.767081 13726 ts_tablet_manager.cc:1950] T b69f231e1f634fedbf5a0ce19ddc3403 P 00495da177c946ff9b82242216b2c960: Deleting consensus metadata
20:03:46.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.770292 13185 catalog_manager.cc:5028] TS 00495da177c946ff9b82242216b2c960 (127.12.212.195:36971): tablet b69f231e1f634fedbf5a0ce19ddc3403 (table TestAuthnTokenReacquireOpen-table [id=475654c190f24deaa26d64be6484bd3f]) successfully deleted
20:03:46.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:46.783465 13187 proxy.cc:239] Call had error, refreshing address and retrying: Network error: recv got EOF from 127.12.212.193:40535 (error 108)
20:03:46.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.783656 13139 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu with pid 13401
20:03:46.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:46.790380 13187 catalog_manager.cc:4755] TS 66a4368f20a14fd9affbe2b33f2dfd95 (127.12.212.193:40535): DeleteTablet:TABLET_DATA_DELETED RPC failed for tablet b69f231e1f634fedbf5a0ce19ddc3403: Network error: Client connection negotiation failed: client connection to 127.12.212.193:40535: connect: Connection refused (error 111)
20:03:46.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.813278 13139 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu with pid 13539
20:03:46.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:46.837898 13139 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskxDOXSZ/build/tsan/bin/kudu with pid 13166
20:03:47.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T20:03:47Z chronyd exiting

Time: 17.805

OK (1 test)

