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

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

14:21:13.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:13.468317 17856 mini_oidc.cc:150] Starting JWKS server
14:21:13.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:13.469213 17856 webserver.cc:533] Webserver started at http://127.0.0.1:35417/ using document root <none> and password file <none>
14:21:13.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:13.469327 17856 mini_oidc.cc:186] Starting OIDC Discovery server
14:21:13.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:13.469503 17856 webserver.cc:533] Webserver started at http://127.0.0.1:40437/ using document root <none> and password file <none>
14:21:13.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
14:21:13.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/principal' for realm 'KRBTEST.COM',
14:21:13.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
14:21:13.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:13 dist-test-slave-7524 krb5kdc[17866](info): setting up network...
14:21:13.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
14:21:13.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:13 dist-test-slave-7524 krb5kdc[17866](info): set up 2 sockets
14:21:13.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:13 dist-test-slave-7524 krb5kdc[17866](info): commencing operation
14:21:13.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
14:21:15.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.341986 17856 mini_kdc.cc:121] Time spent starting KDC: real 1.868s	user 0.000s	sys 0.006s
14:21:15.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
14:21:15.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:21:15.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
14:21:15.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
14:21:15.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:21:15.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
14:21:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
14:21:15.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:21:15.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
14:21:15.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:21:15.421 [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-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/test-user.keytab.
14:21:15.421 [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-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/test-user.keytab.
14:21:15.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:15 dist-test-slave-7524 krb5kdc[17866](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783520475, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:21:15.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
14:21:15.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T14:21:15Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
14:21:15.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T14:21:15Z Disabled control of system clock
14:21:15.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.17.112.62@KRBTEST.COM; defaulting to no policy
14:21:15.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.17.112.62@KRBTEST.COM" created.
14:21:15.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.112.62 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.112.62 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.17.112.62@KRBTEST.COM; defaulting to no policy
14:21:15.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.17.112.62@KRBTEST.COM" created.
14:21:15.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.17.112.62 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.17.112.62 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.489017 17856 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskeWGMCG/build/release/bin/kudu
14:21:15.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskeWGMCG/build/release/bin/kudu
14:21:15.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/wal
14:21:15.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/data
14:21:15.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:21:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:21:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:21:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:15.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/logs
14:21:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/data/info.pb
14:21:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:21:15.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:21:15.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:21:15.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:21:15.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:15.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:15.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:15.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:21:15.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:21:15.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:21:15.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:21:15.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.112.62:46465
14:21:15.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.112.62
14:21:15.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:15.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab
14:21:15.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.112.62
14:21:15.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:21:15.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:21:15.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:21:15.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:21:15.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.112.20:43233
14:21:15.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:15.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:15.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:15.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:21:15.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.112.62:46465
14:21:15.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:21:15.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35417/jwks.json
14:21:15.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:21:15.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
14:21:15.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000 with env {KRB5CCNAME=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:21:15.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.578052 17882 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:21:15.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.578253 17882 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:21:15.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.578279 17882 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:21:15.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.580056 17882 flags.cc:432] Enabled experimental flag: --authn_token_validity_seconds=1
14:21:15.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.580106 17882 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:21:15.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.580120 17882 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:21:15.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.580132 17882 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:21:15.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.580142 17882 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:21:15.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.580154 17882 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:21:15.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.580163 17882 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:35417/jwks.json
14:21:15.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.582877 17882 master_runner.cc:387] Master server non-default flags:
14:21:15.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:15.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.112.20:43233
14:21:15.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:15.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:15.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/data
14:21:15.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/wal
14:21:15.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
14:21:15.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:21:15.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.112.62:46465
14:21:15.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab
14:21:15.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.112.62
14:21:15.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:15.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:15.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:21:15.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.112.62:46465
14:21:15.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:21:15.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:21:15.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:21:15.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35417/jwks.json
14:21:15.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:21:15.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:21:15.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:21:15.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:21:15.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:15.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:15.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/data/info.pb
14:21:15.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.112.62
14:21:15.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:15.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:21:15.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.17882
14:21:15.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:15.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:21:15.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:21:15.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:15.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/logs
14:21:15.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:15.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:21:15.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:21:15.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:21:15.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:21:15.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:21:15.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:21:15.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 13:59:26 UTC on e7f111948823
14:21:15.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16862
14:21:15.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.583150 17882 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:21:15.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.583320 17882 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:21:15.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.586454 17890 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:15.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.586818 17887 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:15.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.586979 17888 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:15.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.587420 17882 server_base.cc:1061] running on GCE node
14:21:15.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.587703 17882 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:21:15.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.587973 17882 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:21:15.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.589111 17882 hybrid_clock.cc:648] HybridClock initialized: now 1783520475589084 us; error 43 us; skew 500 ppm
14:21:15.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:15 dist-test-slave-7524 krb5kdc[17866](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783520475, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.112.62@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:21:15.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.592491 17882 init.cc:377] Logged in from keytab as kudu/127.17.112.62@KRBTEST.COM (short username kudu)
14:21:15.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.593001 17882 webserver.cc:533] Webserver started at http://127.17.112.62:45917/ using document root <none> and password file <none>
14:21:15.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.593182 17882 fs_manager.cc:362] Metadata directory not provided
14:21:15.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.593216 17882 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:21:15.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.593329 17882 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:21:15.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.594447 17882 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/data/instance:
14:21:15.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6b5abd3430204e1bac7611e0ff2ff052"
14:21:15.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:15 on dist-test-slave-7524"
14:21:15.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.594736 17882 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/wal/instance:
14:21:15.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6b5abd3430204e1bac7611e0ff2ff052"
14:21:15.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:15 on dist-test-slave-7524"
14:21:15.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.595992 17882 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.002s	sys 0.000s
14:21:15.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.597131 17897 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:21:15.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.597301 17882 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:21:15.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.597373 17882 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/data,/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/wal
14:21:15.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6b5abd3430204e1bac7611e0ff2ff052"
14:21:15.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:15 on dist-test-slave-7524"
14:21:15.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.597438 17882 fs_report.cc:389] FS layout report
14:21:15.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:21:15.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/wal
14:21:15.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/wal
14:21:15.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/data/data
14:21:15.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:21:15.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:21:15.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:21:15.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:21:15.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:21:15.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:21:15.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:21:15.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:21:15.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:21:15.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:21:15.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:21:15.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.614668 17882 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:21:15.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.617115 17882 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
14:21:15.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.617271 17882 kserver.cc:163] Server-wide thread pool size limit: 3276
14:21:15.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.622205 17882 rpc_server.cc:307] RPC server started. Bound to: 127.17.112.62:46465
14:21:15.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.622236 17949 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.112.62:46465 every 8 connection(s)
14:21:15.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.622655 17882 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/data/info.pb
14:21:15.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.623325 17950 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:21:15.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.624940 17856 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskeWGMCG/build/release/bin/kudu as pid 17882
14:21:15.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.625061 17856 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/master-0/wal/instance
14:21:15.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.626336 17950 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052: Bootstrap starting.
14:21:15.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.627383 17950 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052: Neither blocks nor log segments found. Creating new log.
14:21:15.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.627678 17950 log.cc:826] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052: Log is configured to *not* fsync() on all Append() calls
14:21:15.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.628378 17950 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052: No bootstrap required, opened a new log
14:21:15.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.630154 17950 raft_consensus.cc:359] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "6b5abd3430204e1bac7611e0ff2ff052" member_type: VOTER last_known_addr { host: "127.17.112.62" port: 46465 } }
14:21:15.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.630318 17950 raft_consensus.cc:385] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:21:15.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.630350 17950 raft_consensus.cc:740] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6b5abd3430204e1bac7611e0ff2ff052, State: Initialized, Role: FOLLOWER
14:21:15.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.630455 17950 consensus_queue.cc:260] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [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: "6b5abd3430204e1bac7611e0ff2ff052" member_type: VOTER last_known_addr { host: "127.17.112.62" port: 46465 } }
14:21:15.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.630600 17950 raft_consensus.cc:399] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
14:21:15.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.630666 17950 raft_consensus.cc:493] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
14:21:15.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.630708 17950 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [term 0 FOLLOWER]: Advancing to term 1
14:21:15.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.631474 17950 raft_consensus.cc:515] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "6b5abd3430204e1bac7611e0ff2ff052" member_type: VOTER last_known_addr { host: "127.17.112.62" port: 46465 } }
14:21:15.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.631611 17950 leader_election.cc:304] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [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: 6b5abd3430204e1bac7611e0ff2ff052; no voters: 
14:21:15.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.631773 17950 leader_election.cc:290] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [CANDIDATE]: Term 1 election: Requested vote from peers 
14:21:15.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.632040 17950 sys_catalog.cc:565] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [sys.catalog]: configured and running, proceeding with master startup.
14:21:15.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.633914 17956 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [term 1 FOLLOWER]: Leader election won for term 1
14:21:15.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.634392 17956 raft_consensus.cc:697] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [term 1 LEADER]: Becoming Leader. State: Replica: 6b5abd3430204e1bac7611e0ff2ff052, State: Running, Role: LEADER
14:21:15.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:15 dist-test-slave-7524 krb5kdc[17866](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783520475, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.17.112.62@KRBTEST.COM
14:21:15.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.634812 17956 consensus_queue.cc:237] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [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: "6b5abd3430204e1bac7611e0ff2ff052" member_type: VOTER last_known_addr { host: "127.17.112.62" port: 46465 } }
14:21:15.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.637228 17955 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "6b5abd3430204e1bac7611e0ff2ff052" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "6b5abd3430204e1bac7611e0ff2ff052" member_type: VOTER last_known_addr { host: "127.17.112.62" port: 46465 } } }
14:21:15.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.637316 17955 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [sys.catalog]: This master's current role is: LEADER
14:21:15.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.637586 17968 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 6b5abd3430204e1bac7611e0ff2ff052. Latest consensus state: current_term: 1 leader_uuid: "6b5abd3430204e1bac7611e0ff2ff052" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "6b5abd3430204e1bac7611e0ff2ff052" member_type: VOTER last_known_addr { host: "127.17.112.62" port: 46465 } } }
14:21:15.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.637651 17968 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052 [sys.catalog]: This master's current role is: LEADER
14:21:15.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.639114 17967 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:21:15.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.639166 17967 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:21:15.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.640791 17970 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
14:21:15.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.642557 17970 catalog_manager.cc:1520] Initializing Kudu cluster ID...
14:21:15.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.644059 17970 catalog_manager.cc:1383] Generated new cluster ID: a9679aab402e4f9eb87dc80b506ceb2c
14:21:15.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.644107 17970 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
14:21:15.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.649853 17970 catalog_manager.cc:1406] Generated new certificate authority record
14:21:15.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.650921 17970 catalog_manager.cc:1540] Loading token signing keys...
14:21:15.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.654155 17970 catalog_manager.cc:6070] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052: Generated new TSK 0
14:21:15.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.654328 17970 catalog_manager.cc:1550] Initializing in-progress tserver states...
14:21:15.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.17.112.1@KRBTEST.COM; defaulting to no policy
14:21:15.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.17.112.1@KRBTEST.COM" created.
14:21:15.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.112.1 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.112.1 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.17.112.1@KRBTEST.COM; defaulting to no policy
14:21:15.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.17.112.1@KRBTEST.COM" created.
14:21:15.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.17.112.1 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.17.112.1 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.713773 17856 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskeWGMCG/build/release/bin/kudu
14:21:15.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskeWGMCG/build/release/bin/kudu
14:21:15.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/wal
14:21:15.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/data
14:21:15.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:21:15.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:21:15.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:21:15.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:15.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:15.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:15.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/logs
14:21:15.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/data/info.pb
14:21:15.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:15.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:21:15.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:21:15.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:21:15.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:21:15.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:15.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:15.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:15.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:21:15.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:21:15.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.112.1:0
14:21:15.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.112.1
14:21:15.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.112.1
14:21:15.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:15.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.112.62:46465
14:21:15.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab
14:21:15.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.112.1
14:21:15.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:21:15.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:21:15.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:21:15.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:21:15.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.112.20:43233
14:21:15.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:15.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:15.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:15.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:21:15.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:21:15.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:21:15.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.803972 17978 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:21:15.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.804198 17978 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:21:15.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.804221 17978 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:21:15.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.804250 17978 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:21:15.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.806349 17978 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:21:15.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.806429 17978 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.112.1
14:21:15.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.808393 17978 tablet_server_runner.cc:78] Tablet server non-default flags:
14:21:15.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:15.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.112.20:43233
14:21:15.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:15.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:15.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/data
14:21:15.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/wal
14:21:15.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:21:15.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab
14:21:15.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.112.1
14:21:15.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:15.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:15.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.112.1:0
14:21:15.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:21:15.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:21:15.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:21:15.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:21:15.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:21:15.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:15.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:15.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/data/info.pb
14:21:15.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.112.1
14:21:15.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:15.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.112.62:46465
14:21:15.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:21:15.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.17978
14:21:15.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:15.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:21:15.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:21:15.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:15.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.112.1
14:21:15.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/logs
14:21:15.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:15.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:21:15.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:21:15.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:21:15.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:21:15.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:21:15.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:21:15.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 13:59:26 UTC on e7f111948823
14:21:15.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16862
14:21:15.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.808768 17978 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:21:15.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.809041 17978 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:21:15.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.812922 17984 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:15.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.813230 17983 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:15.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.816388 17978 server_base.cc:1061] running on GCE node
14:21:15.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:15.816789 17986 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:15.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.817019 17978 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:21:15.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.817292 17978 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:21:15.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.818459 17978 hybrid_clock.cc:648] HybridClock initialized: now 1783520475818447 us; error 46 us; skew 500 ppm
14:21:15.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:15 dist-test-slave-7524 krb5kdc[17866](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783520475, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.112.1@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:21:15.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.825186 17978 init.cc:377] Logged in from keytab as kudu/127.17.112.1@KRBTEST.COM (short username kudu)
14:21:15.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.825953 17978 webserver.cc:533] Webserver started at http://127.17.112.1:37229/ using document root <none> and password file <none>
14:21:15.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.826189 17978 fs_manager.cc:362] Metadata directory not provided
14:21:15.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.826243 17978 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:21:15.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.826357 17978 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:21:15.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.827831 17978 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/data/instance:
14:21:15.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e614add0c3ea4d739d93fe1fc25f5313"
14:21:15.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:15 on dist-test-slave-7524"
14:21:15.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.828258 17978 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/wal/instance:
14:21:15.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e614add0c3ea4d739d93fe1fc25f5313"
14:21:15.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:15 on dist-test-slave-7524"
14:21:15.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.829885 17978 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
14:21:15.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.830761 17993 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:21:15.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.830966 17978 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:21:15.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.831055 17978 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/data,/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/wal
14:21:15.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e614add0c3ea4d739d93fe1fc25f5313"
14:21:15.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:15 on dist-test-slave-7524"
14:21:15.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.831123 17978 fs_report.cc:389] FS layout report
14:21:15.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:21:15.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/wal
14:21:15.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/wal
14:21:15.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/data/data
14:21:15.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:21:15.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:21:15.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:21:15.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:21:15.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:21:15.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:21:15.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:21:15.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:21:15.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:21:15.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:21:15.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:21:15.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.846630 17978 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:21:15.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.849097 17978 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
14:21:15.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.849264 17978 kserver.cc:163] Server-wide thread pool size limit: 3276
14:21:15.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.849601 17978 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:21:15.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.850116 17978 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:21:15.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.850157 17978 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:21:15.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.850193 17978 ts_tablet_manager.cc:616] Registered 0 tablets
14:21:15.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.850212 17978 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:21:15.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.858726 17978 rpc_server.cc:307] RPC server started. Bound to: 127.17.112.1:35279
14:21:15.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.858765 18106 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.112.1:35279 every 8 connection(s)
14:21:15.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.859206 17978 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/data/info.pb
14:21:15.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.862664 17856 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskeWGMCG/build/release/bin/kudu as pid 17978
14:21:15.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.862761 17856 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/wal/instance
14:21:15.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:15 dist-test-slave-7524 krb5kdc[17866](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783520475, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.112.1@KRBTEST.COM for kudu/127.17.112.62@KRBTEST.COM
14:21:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.17.112.2@KRBTEST.COM; defaulting to no policy
14:21:15.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.871841 18107 heartbeater.cc:344] Connected to a master server at 127.17.112.62:46465
14:21:15.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.874372 18107 heartbeater.cc:461] Registering TS with master...
14:21:15.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.874701 18107 heartbeater.cc:507] Master 127.17.112.62:46465 requested a full tablet report, sending...
14:21:15.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.17.112.2@KRBTEST.COM" created.
14:21:15.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.875603 17914 ts_manager.cc:194] Registered new tserver with Master: e614add0c3ea4d739d93fe1fc25f5313 (127.17.112.1:35279)
14:21:15.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.876643 17914 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.17.112.1@KRBTEST.COM'} at 127.17.112.1:40485
14:21:15.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.112.2 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.112.2 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.17.112.2@KRBTEST.COM; defaulting to no policy
14:21:15.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.17.112.2@KRBTEST.COM" created.
14:21:15.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:15.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.17.112.2 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.17.112.2 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:15.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:15.924727 17856 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskeWGMCG/build/release/bin/kudu
14:21:15.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskeWGMCG/build/release/bin/kudu
14:21:15.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/wal
14:21:15.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/data
14:21:15.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:21:15.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:21:15.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:21:15.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:15.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:15.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:15.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/logs
14:21:15.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/data/info.pb
14:21:15.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:15.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:21:15.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:21:15.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:21:15.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:21:15.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:15.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:15.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:15.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:21:15.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:21:15.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.112.2:0
14:21:15.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.112.2
14:21:15.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.112.2
14:21:15.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:15.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.112.62:46465
14:21:15.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab
14:21:15.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.112.2
14:21:15.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:21:15.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:21:15.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:21:15.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:21:15.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.112.20:43233
14:21:15.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:15.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:15.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:15.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:21:15.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:21:15.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:21:16.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.019287 18114 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:21:16.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.019513 18114 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:21:16.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.019528 18114 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:21:16.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.019551 18114 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:21:16.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.021955 18114 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:21:16.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.022053 18114 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.112.2
14:21:16.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.024188 18114 tablet_server_runner.cc:78] Tablet server non-default flags:
14:21:16.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.112.20:43233
14:21:16.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/data
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/wal
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.112.2
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.112.2:0
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:21:16.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/data/info.pb
14:21:16.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.112.2
14:21:16.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.112.62:46465
14:21:16.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:21:16.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18114
14:21:16.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:21:16.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:21:16.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.112.2
14:21:16.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/logs
14:21:16.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:21:16.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:21:16.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:21:16.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:21:16.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:21:16.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:21:16.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 13:59:26 UTC on e7f111948823
14:21:16.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16862
14:21:16.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.024453 18114 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:21:16.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.024636 18114 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:21:16.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.027725 18120 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:16.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.027725 18122 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:16.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.027781 18119 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:16.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.028102 18114 server_base.cc:1061] running on GCE node
14:21:16.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.028278 18114 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:21:16.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.028473 18114 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:21:16.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.029615 18114 hybrid_clock.cc:648] HybridClock initialized: now 1783520476029596 us; error 34 us; skew 500 ppm
14:21:16.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:16 dist-test-slave-7524 krb5kdc[17866](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783520476, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.112.2@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:21:16.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.032647 18114 init.cc:377] Logged in from keytab as kudu/127.17.112.2@KRBTEST.COM (short username kudu)
14:21:16.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.033246 18114 webserver.cc:533] Webserver started at http://127.17.112.2:38841/ using document root <none> and password file <none>
14:21:16.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.033480 18114 fs_manager.cc:362] Metadata directory not provided
14:21:16.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.033545 18114 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:21:16.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.033665 18114 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:21:16.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.034771 18114 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/data/instance:
14:21:16.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "78165279b8e942808209ab7e7c973763"
14:21:16.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-7524"
14:21:16.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.035099 18114 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/wal/instance:
14:21:16.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "78165279b8e942808209ab7e7c973763"
14:21:16.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-7524"
14:21:16.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.036759 18114 fs_manager.cc:696] Time spent creating directory manager: real 0.002s	user 0.000s	sys 0.003s
14:21:16.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.037635 18129 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:21:16.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.038100 18114 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:21:16.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.038177 18114 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/data,/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/wal
14:21:16.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "78165279b8e942808209ab7e7c973763"
14:21:16.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-7524"
14:21:16.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.038237 18114 fs_report.cc:389] FS layout report
14:21:16.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/wal
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/wal
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/data/data
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:21:16.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:21:16.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:21:16.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.059772 18114 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:21:16.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.061944 18114 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
14:21:16.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.062068 18114 kserver.cc:163] Server-wide thread pool size limit: 3276
14:21:16.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.062287 18114 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:21:16.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.062634 18114 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:21:16.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.062670 18114 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:21:16.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.062701 18114 ts_tablet_manager.cc:616] Registered 0 tablets
14:21:16.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.062716 18114 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:21:16.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.070624 18114 rpc_server.cc:307] RPC server started. Bound to: 127.17.112.2:37503
14:21:16.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.070668 18242 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.112.2:37503 every 8 connection(s)
14:21:16.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.071077 18114 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/data/info.pb
14:21:16.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.075564 17856 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskeWGMCG/build/release/bin/kudu as pid 18114
14:21:16.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.075655 17856 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/wal/instance
14:21:16.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:16 dist-test-slave-7524 krb5kdc[17866](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783520476, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.112.2@KRBTEST.COM for kudu/127.17.112.62@KRBTEST.COM
14:21:16.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.081074 18243 heartbeater.cc:344] Connected to a master server at 127.17.112.62:46465
14:21:16.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.081177 18243 heartbeater.cc:461] Registering TS with master...
14:21:16.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.081421 18243 heartbeater.cc:507] Master 127.17.112.62:46465 requested a full tablet report, sending...
14:21:16.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.081909 17914 ts_manager.cc:194] Registered new tserver with Master: 78165279b8e942808209ab7e7c973763 (127.17.112.2:37503)
14:21:16.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.082367 17914 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.17.112.2@KRBTEST.COM'} at 127.17.112.2:34735
14:21:16.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.17.112.3@KRBTEST.COM; defaulting to no policy
14:21:16.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:16.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.17.112.3@KRBTEST.COM" created.
14:21:16.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:16.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.112.3 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:16.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.112.3 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:16.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.17.112.3@KRBTEST.COM; defaulting to no policy
14:21:16.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:16.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.17.112.3@KRBTEST.COM" created.
14:21:16.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:21:16.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.17.112.3 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:16.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.17.112.3 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab.
14:21:16.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.120817 17856 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskeWGMCG/build/release/bin/kudu
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskeWGMCG/build/release/bin/kudu
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/wal
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/data
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/logs
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/data/info.pb
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.112.3:0
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.112.3
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.112.3
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.112.62:46465
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.112.3
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:21:16.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:21:16.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.112.20:43233
14:21:16.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:16.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:21:16.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:21:16.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:21:16.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.204137 18250 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:21:16.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.204355 18250 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:21:16.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.204370 18250 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:21:16.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.204391 18250 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:21:16.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.206046 18250 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:21:16.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.206107 18250 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.112.3
14:21:16.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.207819 18250 tablet_server_runner.cc:78] Tablet server non-default flags:
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.112.20:43233
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/data
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/wal
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/kudu.keytab
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.112.3
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.112.3:0
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/data/info.pb
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.112.3
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.112.62:46465
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18250
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.112.3
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/logs
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 13:59:26 UTC on e7f111948823
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16862
14:21:16.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.208041 18250 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:21:16.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.208202 18250 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:21:16.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.210954 18256 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:16.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.211030 18258 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:16.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.210954 18255 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:21:16.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.211229 18250 server_base.cc:1061] running on GCE node
14:21:16.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.211377 18250 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:21:16.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.211587 18250 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:21:16.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.212733 18250 hybrid_clock.cc:648] HybridClock initialized: now 1783520476212719 us; error 28 us; skew 500 ppm
14:21:16.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:16 dist-test-slave-7524 krb5kdc[17866](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783520476, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.112.3@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:21:16.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.215595 18250 init.cc:377] Logged in from keytab as kudu/127.17.112.3@KRBTEST.COM (short username kudu)
14:21:16.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.216085 18250 webserver.cc:533] Webserver started at http://127.17.112.3:34941/ using document root <none> and password file <none>
14:21:16.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.216285 18250 fs_manager.cc:362] Metadata directory not provided
14:21:16.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.216355 18250 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:21:16.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.216477 18250 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:21:16.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.217489 18250 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/data/instance:
14:21:16.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f2863187962f4e368e539ea8e634fa82"
14:21:16.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-7524"
14:21:16.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.217895 18250 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/wal/instance:
14:21:16.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f2863187962f4e368e539ea8e634fa82"
14:21:16.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-7524"
14:21:16.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.219477 18250 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.001s
14:21:16.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.220340 18265 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:21:16.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.220533 18250 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
14:21:16.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.220615 18250 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/data,/tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/wal
14:21:16.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f2863187962f4e368e539ea8e634fa82"
14:21:16.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-7524"
14:21:16.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.220678 18250 fs_report.cc:389] FS layout report
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/wal
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/wal
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/data/data
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:21:16.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:21:16.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.239351 18250 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:21:16.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.241051 18250 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
14:21:16.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.241168 18250 kserver.cc:163] Server-wide thread pool size limit: 3276
14:21:16.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.241380 18250 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:21:16.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.241704 18250 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:21:16.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.241808 18250 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:21:16.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.241832 18250 ts_tablet_manager.cc:616] Registered 0 tablets
14:21:16.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.241843 18250 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:21:16.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.248468 18250 rpc_server.cc:307] RPC server started. Bound to: 127.17.112.3:41293
14:21:16.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.248517 18378 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.112.3:41293 every 8 connection(s)
14:21:16.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.248883 18250 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/data/info.pb
14:21:16.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:16 dist-test-slave-7524 krb5kdc[17866](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783520476, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.112.3@KRBTEST.COM for kudu/127.17.112.62@KRBTEST.COM
14:21:16.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.256292 17856 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskeWGMCG/build/release/bin/kudu as pid 18250
14:21:16.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.256378 17856 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/wal/instance
14:21:16.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.258545 18379 heartbeater.cc:344] Connected to a master server at 127.17.112.62:46465
14:21:16.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.258643 18379 heartbeater.cc:461] Registering TS with master...
14:21:16.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.258821 18379 heartbeater.cc:507] Master 127.17.112.62:46465 requested a full tablet report, sending...
14:21:16.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.259186 17914 ts_manager.cc:194] Registered new tserver with Master: f2863187962f4e368e539ea8e634fa82 (127.17.112.3:41293)
14:21:16.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.259553 17914 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.17.112.3@KRBTEST.COM'} at 127.17.112.3:39141
14:21:16.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.268736 17856 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
14:21:16.270 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:21:16.271 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

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

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

14:21:16.289 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.17.112.62"
      port: 46465
    }
    bound_http_address {
      host: "127.17.112.62"
      port: 45917
    }
  }
}

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

14:21:16.294 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.17.112.1"
      port: 35279
    }
    bound_http_address {
      host: "127.17.112.1"
      port: 37229
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.17.112.2"
      port: 37503
    }
    bound_http_address {
      host: "127.17.112.2"
      port: 38841
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.17.112.3"
      port: 41293
    }
    bound_http_address {
      host: "127.17.112.3"
      port: 34941
    }
  }
}

14:21:16.295 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
14:21:16.506 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
14:21:16.533 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/krb5kdc/krb5cc
14:21:16.581 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
14:21:16.696 [DEBUG - main] (Connection.java:748) [peer master-127.17.112.62:46465(127.17.112.62:46465)] connecting to peer
14:21:16.766 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.17.112.62:46465(127.17.112.62:46465)] Successfully connected to peer
14:21:16.874 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism GSSAPI chosen for peer 127.17.112.62
14:21:16.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.878072 18107 heartbeater.cc:499] Master 127.17.112.62:46465 was elected leader, sending a full tablet report...
14:21:17.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.083244 18243 heartbeater.cc:499] Master 127.17.112.62:46465 was elected leader, sending a full tablet report...
14:21:17.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 14:21:17 dist-test-slave-7524 krb5kdc[17866](info): TGS_REQ (1 etypes {17}) 127.0.0.1: ISSUE: authtime 1783520475, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.17.112.62@KRBTEST.COM
14:21:17.150 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0x493545f4, L:/127.0.0.1:54122 - R:/127.17.112.62:46465] using SASL/GSSAPI
14:21:17.186 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:21:17.187 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTabletServers, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=530), Traces: [0ms] refreshing cache from master, [25ms] Sub RPC ConnectToMaster: sending RPC to server master-127.17.112.62:46465, [505ms] Sub RPC ConnectToMaster: received response from server master-127.17.112.62:46465: OK, deferred=null) after lookup
14:21:17.209 [DEBUG - main] (Connection.java:575) [peer master-127.17.112.62:46465(127.17.112.62:46465)] disconnecting while in state READY
14:21:17.217 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.17.112.62:46465(127.17.112.62:46465)] handling channelInactive
14:21:17.218 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.17.112.62:46465(127.17.112.62:46465)] cleaning up while in state READY due to: connection closed
14:21:17.219 [INFO - kudu-nio-0] (AsyncKuduClient.java:2355) Invalidating location master-127.17.112.62:46465(127.17.112.62:46465) for tablet Kudu Master: connection closed
14:21:17.239 [DEBUG - pool-2-thread-1] (Connection.java:748) [peer master-127.17.112.62:46465(127.17.112.62:46465)] connecting to peer
14:21:17.242 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.17.112.62:46465(127.17.112.62:46465)] Successfully connected to peer
14:21:17.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.260367 18379 heartbeater.cc:499] Master 127.17.112.62:46465 was elected leader, sending a full tablet report...
14:21:17.304 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0xa1719841, L:/127.0.0.1:52006 - R:/127.17.112.62:46465] using TOKEN/null
14:21:17.308 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:21:17.308 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=Kudu Master, attempt=2, TimeoutTracker(timeout=50000, elapsed=98), Traces: [0ms] sending RPC to server master-127.17.112.62:46465, [8ms] received response from server master-127.17.112.62:46465: Network error: connection closed, [9ms] delaying RPC due to: Network error: connection closed, [28ms] refreshing cache from master, [29ms] Sub RPC ConnectToMaster: sending RPC to server master-127.17.112.62:46465, [97ms] Sub RPC ConnectToMaster: received response from server master-127.17.112.62:46465: OK, deferred=Deferred@1209056325(state=PENDING, result=null, callback=wakeup thread main, errback=wakeup thread main)) after lookup
14:21:17.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.373304 17914 catalog_manager.cc:2283] Servicing CreateTable request from {username='test-admin'} at 127.0.0.1:52006:
14:21:17.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "TestAuthnTokenReacquireOpen-table"
14:21:17.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
14:21:17.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:21:17.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
14:21:17.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:21:17.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
14:21:17.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:21:17.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:21:17.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:21:17.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:21:17.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
14:21:17.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
14:21:17.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
14:21:17.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:21:17.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:21:17.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:21:17.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.374987 17914 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.
14:21:17.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.386837 18041 tablet_service.cc:1511] Processing CreateTablet for tablet d3145c58e8c4437aaaeb1f1c63d847a9 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=ff1bcbae717e4c7d9574933c51ac28ed]), partition=RANGE (key) PARTITION UNBOUNDED
14:21:17.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.387257 18041 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d3145c58e8c4437aaaeb1f1c63d847a9. 1 dirs total, 0 dirs full, 0 dirs failed
14:21:17.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.387395 18313 tablet_service.cc:1511] Processing CreateTablet for tablet d3145c58e8c4437aaaeb1f1c63d847a9 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=ff1bcbae717e4c7d9574933c51ac28ed]), partition=RANGE (key) PARTITION UNBOUNDED
14:21:17.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.387652 18313 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d3145c58e8c4437aaaeb1f1c63d847a9. 1 dirs total, 0 dirs full, 0 dirs failed
14:21:17.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.390789 18397 tablet_bootstrap.cc:492] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: Bootstrap starting.
14:21:17.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.391561 18397 tablet_bootstrap.cc:654] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: Neither blocks nor log segments found. Creating new log.
14:21:17.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.391897 18397 log.cc:826] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: Log is configured to *not* fsync() on all Append() calls
14:21:17.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.392290 18398 tablet_bootstrap.cc:492] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: Bootstrap starting.
14:21:17.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.392980 18398 tablet_bootstrap.cc:654] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: Neither blocks nor log segments found. Creating new log.
14:21:17.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.393316 18398 log.cc:826] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: Log is configured to *not* fsync() on all Append() calls
14:21:17.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.394098 18397 tablet_bootstrap.cc:492] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: No bootstrap required, opened a new log
14:21:17.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.394174 18397 ts_tablet_manager.cc:1403] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: Time spent bootstrapping tablet: real 0.003s	user 0.001s	sys 0.000s
14:21:17.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.395898 18397 raft_consensus.cc:359] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e614add0c3ea4d739d93fe1fc25f5313" member_type: VOTER last_known_addr { host: "127.17.112.1" port: 35279 } } peers { permanent_uuid: "78165279b8e942808209ab7e7c973763" member_type: VOTER last_known_addr { host: "127.17.112.2" port: 37503 } } peers { permanent_uuid: "f2863187962f4e368e539ea8e634fa82" member_type: VOTER last_known_addr { host: "127.17.112.3" port: 41293 } }
14:21:17.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.396070 18397 raft_consensus.cc:385] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:21:17.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.396106 18397 raft_consensus.cc:740] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e614add0c3ea4d739d93fe1fc25f5313, State: Initialized, Role: FOLLOWER
14:21:17.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.396271 18397 consensus_queue.cc:260] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [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: "e614add0c3ea4d739d93fe1fc25f5313" member_type: VOTER last_known_addr { host: "127.17.112.1" port: 35279 } } peers { permanent_uuid: "78165279b8e942808209ab7e7c973763" member_type: VOTER last_known_addr { host: "127.17.112.2" port: 37503 } } peers { permanent_uuid: "f2863187962f4e368e539ea8e634fa82" member_type: VOTER last_known_addr { host: "127.17.112.3" port: 41293 } }
14:21:17.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.396560 18397 ts_tablet_manager.cc:1434] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: Time spent starting tablet: real 0.002s	user 0.003s	sys 0.000s
14:21:17.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.398212 18398 tablet_bootstrap.cc:492] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: No bootstrap required, opened a new log
14:21:17.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.398291 18398 ts_tablet_manager.cc:1403] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: Time spent bootstrapping tablet: real 0.006s	user 0.002s	sys 0.000s
14:21:17.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.399417 18177 tablet_service.cc:1511] Processing CreateTablet for tablet d3145c58e8c4437aaaeb1f1c63d847a9 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=ff1bcbae717e4c7d9574933c51ac28ed]), partition=RANGE (key) PARTITION UNBOUNDED
14:21:17.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.399726 18177 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d3145c58e8c4437aaaeb1f1c63d847a9. 1 dirs total, 0 dirs full, 0 dirs failed
14:21:17.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.400095 18398 raft_consensus.cc:359] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e614add0c3ea4d739d93fe1fc25f5313" member_type: VOTER last_known_addr { host: "127.17.112.1" port: 35279 } } peers { permanent_uuid: "78165279b8e942808209ab7e7c973763" member_type: VOTER last_known_addr { host: "127.17.112.2" port: 37503 } } peers { permanent_uuid: "f2863187962f4e368e539ea8e634fa82" member_type: VOTER last_known_addr { host: "127.17.112.3" port: 41293 } }
14:21:17.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.400243 18398 raft_consensus.cc:385] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:21:17.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.400272 18398 raft_consensus.cc:740] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f2863187962f4e368e539ea8e634fa82, State: Initialized, Role: FOLLOWER
14:21:17.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.401422 18398 consensus_queue.cc:260] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82 [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: "e614add0c3ea4d739d93fe1fc25f5313" member_type: VOTER last_known_addr { host: "127.17.112.1" port: 35279 } } peers { permanent_uuid: "78165279b8e942808209ab7e7c973763" member_type: VOTER last_known_addr { host: "127.17.112.2" port: 37503 } } peers { permanent_uuid: "f2863187962f4e368e539ea8e634fa82" member_type: VOTER last_known_addr { host: "127.17.112.3" port: 41293 } }
14:21:17.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.401787 18398 ts_tablet_manager.cc:1434] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: Time spent starting tablet: real 0.003s	user 0.002s	sys 0.000s
14:21:17.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.404042 18403 tablet_bootstrap.cc:492] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: Bootstrap starting.
14:21:17.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.404997 18403 tablet_bootstrap.cc:654] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: Neither blocks nor log segments found. Creating new log.
14:21:17.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.405555 18403 log.cc:826] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: Log is configured to *not* fsync() on all Append() calls
14:21:17.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.406507 18403 tablet_bootstrap.cc:492] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: No bootstrap required, opened a new log
14:21:17.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.406572 18403 ts_tablet_manager.cc:1403] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: Time spent bootstrapping tablet: real 0.003s	user 0.002s	sys 0.000s
14:21:17.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.408232 18403 raft_consensus.cc:359] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e614add0c3ea4d739d93fe1fc25f5313" member_type: VOTER last_known_addr { host: "127.17.112.1" port: 35279 } } peers { permanent_uuid: "78165279b8e942808209ab7e7c973763" member_type: VOTER last_known_addr { host: "127.17.112.2" port: 37503 } } peers { permanent_uuid: "f2863187962f4e368e539ea8e634fa82" member_type: VOTER last_known_addr { host: "127.17.112.3" port: 41293 } }
14:21:17.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.408388 18403 raft_consensus.cc:385] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:21:17.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.408417 18403 raft_consensus.cc:740] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 78165279b8e942808209ab7e7c973763, State: Initialized, Role: FOLLOWER
14:21:17.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.408531 18403 consensus_queue.cc:260] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763 [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: "e614add0c3ea4d739d93fe1fc25f5313" member_type: VOTER last_known_addr { host: "127.17.112.1" port: 35279 } } peers { permanent_uuid: "78165279b8e942808209ab7e7c973763" member_type: VOTER last_known_addr { host: "127.17.112.2" port: 37503 } } peers { permanent_uuid: "f2863187962f4e368e539ea8e634fa82" member_type: VOTER last_known_addr { host: "127.17.112.3" port: 41293 } }
14:21:17.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.408838 18403 ts_tablet_manager.cc:1434] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: Time spent starting tablet: real 0.002s	user 0.002s	sys 0.000s
14:21:17.414 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table ff1bcbae717e4c7d9574933c51ac28ed
14:21:17.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.500324 18380 tablet.cc:2406] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:21:17.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.572751 18244 tablet.cc:2406] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:21:17.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.585023 18401 raft_consensus.cc:493] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:21:17.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.585214 18401 raft_consensus.cc:515] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e614add0c3ea4d739d93fe1fc25f5313" member_type: VOTER last_known_addr { host: "127.17.112.1" port: 35279 } } peers { permanent_uuid: "78165279b8e942808209ab7e7c973763" member_type: VOTER last_known_addr { host: "127.17.112.2" port: 37503 } } peers { permanent_uuid: "f2863187962f4e368e539ea8e634fa82" member_type: VOTER last_known_addr { host: "127.17.112.3" port: 41293 } }
14:21:17.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.585650 18401 leader_election.cc:290] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 78165279b8e942808209ab7e7c973763 (127.17.112.2:37503), f2863187962f4e368e539ea8e634fa82 (127.17.112.3:41293)
14:21:17.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.589458 18197 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d3145c58e8c4437aaaeb1f1c63d847a9" candidate_uuid: "e614add0c3ea4d739d93fe1fc25f5313" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "78165279b8e942808209ab7e7c973763" is_pre_election: true
14:21:17.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.589663 18197 raft_consensus.cc:2468] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate e614add0c3ea4d739d93fe1fc25f5313 in term 0.
14:21:17.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.589965 17995 leader_election.cc:304] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [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: 78165279b8e942808209ab7e7c973763, e614add0c3ea4d739d93fe1fc25f5313; no voters: 
14:21:17.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.590137 18401 raft_consensus.cc:2804] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 0 FOLLOWER]: Leader pre-election won for term 1
14:21:17.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.590193 18401 raft_consensus.cc:493] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:21:17.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.590217 18401 raft_consensus.cc:3060] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 0 FOLLOWER]: Advancing to term 1
14:21:17.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.591017 18333 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d3145c58e8c4437aaaeb1f1c63d847a9" candidate_uuid: "e614add0c3ea4d739d93fe1fc25f5313" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f2863187962f4e368e539ea8e634fa82" is_pre_election: true
14:21:17.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.591184 18333 raft_consensus.cc:2468] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate e614add0c3ea4d739d93fe1fc25f5313 in term 0.
14:21:17.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.591235 18401 raft_consensus.cc:515] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e614add0c3ea4d739d93fe1fc25f5313" member_type: VOTER last_known_addr { host: "127.17.112.1" port: 35279 } } peers { permanent_uuid: "78165279b8e942808209ab7e7c973763" member_type: VOTER last_known_addr { host: "127.17.112.2" port: 37503 } } peers { permanent_uuid: "f2863187962f4e368e539ea8e634fa82" member_type: VOTER last_known_addr { host: "127.17.112.3" port: 41293 } }
14:21:17.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.591354 18401 leader_election.cc:290] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [CANDIDATE]: Term 1 election: Requested vote from peers 78165279b8e942808209ab7e7c973763 (127.17.112.2:37503), f2863187962f4e368e539ea8e634fa82 (127.17.112.3:41293)
14:21:17.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.591529 18333 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d3145c58e8c4437aaaeb1f1c63d847a9" candidate_uuid: "e614add0c3ea4d739d93fe1fc25f5313" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f2863187962f4e368e539ea8e634fa82"
14:21:17.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.591527 18197 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d3145c58e8c4437aaaeb1f1c63d847a9" candidate_uuid: "e614add0c3ea4d739d93fe1fc25f5313" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "78165279b8e942808209ab7e7c973763"
14:21:17.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.591607 18333 raft_consensus.cc:3060] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82 [term 0 FOLLOWER]: Advancing to term 1
14:21:17.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.591609 18197 raft_consensus.cc:3060] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763 [term 0 FOLLOWER]: Advancing to term 1
14:21:17.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.592450 18333 raft_consensus.cc:2468] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate e614add0c3ea4d739d93fe1fc25f5313 in term 1.
14:21:17.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.592450 18197 raft_consensus.cc:2468] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate e614add0c3ea4d739d93fe1fc25f5313 in term 1.
14:21:17.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.592622 17995 leader_election.cc:304] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [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: 78165279b8e942808209ab7e7c973763, e614add0c3ea4d739d93fe1fc25f5313; no voters: 
14:21:17.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.592711 18401 raft_consensus.cc:2804] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 1 FOLLOWER]: Leader election won for term 1
14:21:17.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.592854 18401 raft_consensus.cc:697] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 1 LEADER]: Becoming Leader. State: Replica: e614add0c3ea4d739d93fe1fc25f5313, State: Running, Role: LEADER
14:21:17.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.592947 18401 consensus_queue.cc:237] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [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: "e614add0c3ea4d739d93fe1fc25f5313" member_type: VOTER last_known_addr { host: "127.17.112.1" port: 35279 } } peers { permanent_uuid: "78165279b8e942808209ab7e7c973763" member_type: VOTER last_known_addr { host: "127.17.112.2" port: 37503 } } peers { permanent_uuid: "f2863187962f4e368e539ea8e634fa82" member_type: VOTER last_known_addr { host: "127.17.112.3" port: 41293 } }
14:21:17.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.593885 17914 catalog_manager.cc:5697] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 reported cstate change: term changed from 0 to 1, leader changed from <none> to e614add0c3ea4d739d93fe1fc25f5313 (127.17.112.1). New cstate: current_term: 1 leader_uuid: "e614add0c3ea4d739d93fe1fc25f5313" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e614add0c3ea4d739d93fe1fc25f5313" member_type: VOTER last_known_addr { host: "127.17.112.1" port: 35279 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "78165279b8e942808209ab7e7c973763" member_type: VOTER last_known_addr { host: "127.17.112.2" port: 37503 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "f2863187962f4e368e539ea8e634fa82" member_type: VOTER last_known_addr { host: "127.17.112.3" port: 41293 } health_report { overall_health: UNKNOWN } } }
14:21:17.608 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table ff1bcbae717e4c7d9574933c51ac28ed
14:21:17.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.610980 18108 tablet.cc:2406] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:21:18.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.159440 18410 consensus_queue.cc:1048] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [LEADER]: Connected to new peer: Peer: permanent_uuid: "f2863187962f4e368e539ea8e634fa82" member_type: VOTER last_known_addr { host: "127.17.112.3" port: 41293 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:21:18.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.161911 18413 consensus_queue.cc:1048] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [LEADER]: Connected to new peer: Peer: permanent_uuid: "78165279b8e942808209ab7e7c973763" member_type: VOTER last_known_addr { host: "127.17.112.2" port: 37503 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:21:18.612 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table ff1bcbae717e4c7d9574933c51ac28ed
14:21:18.634 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet d3145c58e8c4437aaaeb1f1c63d847a9 for table 'TestAuthnTokenReacquireOpen-table' with partition [<start>, <end>)
14:21:18.640 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=d3145c58e8c4437aaaeb1f1c63d847a9@[78165279b8e942808209ab7e7c973763(127.17.112.2:37503),e614add0c3ea4d739d93fe1fc25f5313(127.17.112.1:35279)[L],f2863187962f4e368e539ea8e634fa82(127.17.112.3:41293)]}]
14:21:18.648 [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.17.112.62:46465, [7ms] Sub RPC GetTableLocations: received response from server master-127.17.112.62:46465: OK, deferred=null)) after lookup
14:21:18.659 [DEBUG - kudu-nio-1] (Connection.java:748) [peer e614add0c3ea4d739d93fe1fc25f5313(127.17.112.1:35279)] connecting to peer
14:21:18.662 [DEBUG - kudu-nio-2] (Connection.java:757) [peer e614add0c3ea4d739d93fe1fc25f5313(127.17.112.1:35279)] Successfully connected to peer
14:21:18.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:18.714339 18421 fault_injection.cc:43] FAULT INJECTION ENABLED!
14:21:18.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:18.714450 18421 fault_injection.cc:44] THIS SERVER MAY CRASH!
14:21:18.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:18.714818 18421 negotiation.cc:343] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:56486: token signing key expired
14:21:18.720 [DEBUG - kudu-nio-2] (Negotiator.java:351) peer /127.17.112.1:35279 sent connection negotiation error: Not authorized: token signing key expired
14:21:18.722 [DEBUG - kudu-nio-2] (Connection.java:239) [peer e614add0c3ea4d739d93fe1fc25f5313(127.17.112.1:35279)] handling channelInactive
14:21:18.722 [DEBUG - kudu-nio-2] (Connection.java:709) [peer e614add0c3ea4d739d93fe1fc25f5313(127.17.112.1:35279)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
14:21:18.724 [DEBUG - kudu-nio-2] (Connection.java:748) [peer master-127.17.112.62:46465(127.17.112.62:46465)] connecting to peer
14:21:18.726 [DEBUG - kudu-nio-3] (Connection.java:757) [peer master-127.17.112.62:46465(127.17.112.62:46465)] Successfully connected to peer
14:21:18.735 [DEBUG - kudu-nio-3] (Negotiator.java:528) SASL mechanism GSSAPI chosen for peer 127.17.112.62
14:21:18.775 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0x59b1ba4a, L:/127.0.0.1:52022 - R:/127.17.112.62:46465] using SASL/GSSAPI
14:21:18.777 [INFO - kudu-nio-3] (AsyncKuduClient.java:516) connect to master: received a new authn token
14:21:18.778 [DEBUG - kudu-nio-3] (Connection.java:748) [peer e614add0c3ea4d739d93fe1fc25f5313(127.17.112.1:35279)] connecting to peer
14:21:18.780 [DEBUG - kudu-nio-4] (Connection.java:757) [peer e614add0c3ea4d739d93fe1fc25f5313(127.17.112.1:35279)] Successfully connected to peer
14:21:18.808 [DEBUG - kudu-nio-4] (Negotiator.java:918) Authenticated connection [id: 0xd6b33b87, L:/127.0.0.1:56494 - R:/127.17.112.1:35279] using TOKEN/null
14:21:18.842 [DEBUG - kudu-nio-4] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 0 rows, more = false) for scanner KuduScanner(table=TestAuthnTokenReacquireOpen-table, tablet=d3145c58e8c4437aaaeb1f1c63d847a9, scannerId=null, scanRequestTimeout=60000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:21:18.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.854715 17914 catalog_manager.cc:2533] Servicing SoftDeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:52022:
14:21:18.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
14:21:18.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.854889 17914 catalog_manager.cc:2781] Servicing DeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:52022:
14:21:18.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
14:21:18.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.859627 17914 catalog_manager.cc:5984] T 00000000000000000000000000000000 P 6b5abd3430204e1bac7611e0ff2ff052: Sending DeleteTablet for 3 replicas of tablet d3145c58e8c4437aaaeb1f1c63d847a9
14:21:18.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.860141 18041 tablet_service.cc:1558] Processing DeleteTablet for tablet d3145c58e8c4437aaaeb1f1c63d847a9 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 14:21:18 UTC) from {username='kudu', principal='kudu/127.17.112.62@KRBTEST.COM'} at 127.0.0.1:56476
14:21:18.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.860298 18177 tablet_service.cc:1558] Processing DeleteTablet for tablet d3145c58e8c4437aaaeb1f1c63d847a9 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 14:21:18 UTC) from {username='kudu', principal='kudu/127.17.112.62@KRBTEST.COM'} at 127.0.0.1:44794
14:21:18.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.860376 18313 tablet_service.cc:1558] Processing DeleteTablet for tablet d3145c58e8c4437aaaeb1f1c63d847a9 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 14:21:18 UTC) from {username='kudu', principal='kudu/127.17.112.62@KRBTEST.COM'} at 127.0.0.1:42172
14:21:18.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.860548 18432 tablet_replica.cc:333] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: stopping tablet replica
14:21:18.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.860672 18432 raft_consensus.cc:2243] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763 [term 1 FOLLOWER]: Raft consensus shutting down.
14:21:18.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.860764 18432 raft_consensus.cc:2272] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763 [term 1 FOLLOWER]: Raft consensus is shut down!
14:21:18.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.860957 18433 tablet_replica.cc:333] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: stopping tablet replica
14:21:18.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.861059 18433 raft_consensus.cc:2243] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82 [term 1 FOLLOWER]: Raft consensus shutting down.
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.861125 18433 raft_consensus.cc:2272] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82 [term 1 FOLLOWER]: Raft consensus is shut down!
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.861272 18432 ts_tablet_manager.cc:1916] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: Deleting tablet data with delete state TABLET_DATA_DELETED
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.861292 18431 tablet_replica.cc:333] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: stopping tablet replica
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.861392 18431 raft_consensus.cc:2243] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 1 LEADER]: Raft consensus shutting down.
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.861512 18431 raft_consensus.cc:2272] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313 [term 1 FOLLOWER]: Raft consensus is shut down!
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.861938 18431 ts_tablet_manager.cc:1916] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: Deleting tablet data with delete state TABLET_DATA_DELETED
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.863619 18431 ts_tablet_manager.cc:1929] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.863689 18431 log.cc:1199] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: Deleting WAL directory at /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-0/wal/wals/d3145c58e8c4437aaaeb1f1c63d847a9
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.863986 18431 ts_tablet_manager.cc:1950] T d3145c58e8c4437aaaeb1f1c63d847a9 P e614add0c3ea4d739d93fe1fc25f5313: Deleting consensus metadata
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.864464 18432 ts_tablet_manager.cc:1929] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.864530 18432 log.cc:1199] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: Deleting WAL directory at /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-1/wal/wals/d3145c58e8c4437aaaeb1f1c63d847a9
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.864560 17901 catalog_manager.cc:5028] TS e614add0c3ea4d739d93fe1fc25f5313 (127.17.112.1:35279): tablet d3145c58e8c4437aaaeb1f1c63d847a9 (table TestAuthnTokenReacquireOpen-table [id=ff1bcbae717e4c7d9574933c51ac28ed]) successfully deleted
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.864816 18432 ts_tablet_manager.cc:1950] T d3145c58e8c4437aaaeb1f1c63d847a9 P 78165279b8e942808209ab7e7c973763: Deleting consensus metadata
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.865262 17899 catalog_manager.cc:5028] TS 78165279b8e942808209ab7e7c973763 (127.17.112.2:37503): tablet d3145c58e8c4437aaaeb1f1c63d847a9 (table TestAuthnTokenReacquireOpen-table [id=ff1bcbae717e4c7d9574933c51ac28ed]) successfully deleted
14:21:18.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.865412 18433 ts_tablet_manager.cc:1916] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: Deleting tablet data with delete state TABLET_DATA_DELETED
14:21:18.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.867496 18433 ts_tablet_manager.cc:1929] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:21:18.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.867578 18433 log.cc:1199] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: Deleting WAL directory at /tmp/dist-test-taskeWGMCG/test-tmp/mini-kudu-cluster3320604350819917770/ts-2/wal/wals/d3145c58e8c4437aaaeb1f1c63d847a9
14:21:18.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.867859 18433 ts_tablet_manager.cc:1950] T d3145c58e8c4437aaaeb1f1c63d847a9 P f2863187962f4e368e539ea8e634fa82: Deleting consensus metadata
14:21:18.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.868341 17899 catalog_manager.cc:5028] TS f2863187962f4e368e539ea8e634fa82 (127.17.112.3:41293): tablet d3145c58e8c4437aaaeb1f1c63d847a9 (table TestAuthnTokenReacquireOpen-table [id=ff1bcbae717e4c7d9574933c51ac28ed]) successfully deleted
14:21:18.871 [DEBUG - main] (Connection.java:575) [peer e614add0c3ea4d739d93fe1fc25f5313(127.17.112.1:35279)] disconnecting while in state READY
14:21:18.872 [DEBUG - main] (Connection.java:575) [peer master-127.17.112.62:46465(127.17.112.62:46465)] disconnecting while in state READY
14:21:18.872 [DEBUG - main] (Connection.java:575) [peer master-127.17.112.62:46465(127.17.112.62:46465)] disconnecting while in state READY
14:21:18.873 [DEBUG - kudu-nio-4] (Connection.java:239) [peer e614add0c3ea4d739d93fe1fc25f5313(127.17.112.1:35279)] handling channelInactive
14:21:18.873 [DEBUG - kudu-nio-4] (Connection.java:709) [peer e614add0c3ea4d739d93fe1fc25f5313(127.17.112.1:35279)] cleaning up while in state READY due to: connection closed
14:21:18.873 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.17.112.62:46465(127.17.112.62:46465)] handling channelInactive
14:21:18.873 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.17.112.62:46465(127.17.112.62:46465)] cleaning up while in state READY due to: connection closed
14:21:18.874 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:21:18.878 [DEBUG - kudu-nio-3] (Connection.java:239) [peer master-127.17.112.62:46465(127.17.112.62:46465)] handling channelInactive
14:21:18.878 [DEBUG - kudu-nio-3] (Connection.java:709) [peer master-127.17.112.62:46465(127.17.112.62:46465)] cleaning up while in state READY due to: connection closed
14:21:18.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.878433 17856 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskeWGMCG/build/release/bin/kudu with pid 17978
14:21:18.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.884166 17856 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskeWGMCG/build/release/bin/kudu with pid 18114
14:21:18.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.888986 17856 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskeWGMCG/build/release/bin/kudu with pid 18250
14:21:18.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.893415 17856 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskeWGMCG/build/release/bin/kudu with pid 17882
14:21:18.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T14:21:18Z chronyd exiting

Time: 5.812

OK (1 test)

