JUnit version 4.13.2
.SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in [jar:file:/tmp/dist-test-taskdU6HUy/java/build/jars/log4j-slf4j-impl-2.17.1.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: Found binding in [jar:file:/tmp/dist-test-taskdU6HUy/java/build/jars/slf4j-log4j12-1.7.30.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory]
14:28:45.556 [INFO - main] (RandomUtils.java:49) Using random seed: 1786458525553
14:28:45.581 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
14:28:45.626 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
14:28:45.634 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskdU6HUy/test-tmp
14:28:45.636 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
14:28:45.639 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskdU6HUy/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
14:28:45.658 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

14:28:45.817 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:28:45.824 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

14:28:45.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.825415  1208 mini_oidc.cc:152] Starting JWKS server
14:28:45.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.826476  1208 webserver.cc:460] Webserver started at http://127.0.0.1:45219/ using document root <none> and password file <none>
14:28:45.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.826567  1208 mini_oidc.cc:189] Starting OIDC Discovery server
14:28:45.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.826714  1208 webserver.cc:460] Webserver started at http://127.0.0.1:45257/ using document root <none> and password file <none>
14:28:45.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T14:28:45Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
14:28:45.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T14:28:45Z Disabled control of system clock
14:28:45.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.839695  1208 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:45.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:45.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/wal
14:28:45.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/data
14:28:45.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:28:45.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:28:45.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:28:45.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:45.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:45.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:45.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/logs
14:28:45.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/data/info.pb
14:28:45.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:45.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:28:45.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:28:45.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:28:45.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:28:45.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:45.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:45.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:45.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:28:45.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:28:45.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:28:45.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:28:45.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.62:34223
14:28:45.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.62
14:28:45.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:45.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:45.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:45.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:45.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:45.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:28:45.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:45.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:28:45.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45219/jwks.json with env {}
14:28:45.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.920720  1225 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
14:28:45.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.920897  1225 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:28:45.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.920915  1225 flags.cc:425] Enabled unsafe flag: --never_fsync=true
14:28:45.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.922287  1225 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
14:28:45.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.922358  1225 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
14:28:45.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.922379  1225 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
14:28:45.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.922395  1225 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
14:28:45.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.922411  1225 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
14:28:45.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.922426  1225 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45219/jwks.json
14:28:45.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.924369  1225 master_runner.cc:386] Master server non-default flags:
14:28:45.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:45.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:45.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:45.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:45.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/data
14:28:45.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/wal
14:28:45.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:28:45.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:45.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:45.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:45.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:28:45.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.62:34223
14:28:45.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:28:45.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:28:45.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:28:45.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45219/jwks.json
14:28:45.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:45.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:45.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/data/info.pb
14:28:45.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.62
14:28:45.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:45.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:28:45.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.1225
14:28:45.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:45.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:28:45.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:28:45.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:45.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/logs
14:28:45.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:45.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:28:45.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:28:45.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:28:45.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
14:28:45.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
14:28:45.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:28:45.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:41:36 UTC on ccycloud.quasar-ebruqk.root.comops.site
14:28:45.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580675
14:28:45.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.924612  1225 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:28:45.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.924912  1225 file_cache.cc:493] Constructed file cache file cache with capacity 419430
14:28:45.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.929729  1231 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:28:45.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.929754  1240 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:28:45.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.929767  1235 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:28:45.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.929917  1225 server_base.cc:1034] running on GCE node
14:28:45.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.930402  1225 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:28:45.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.930646  1225 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:28:45.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.931789  1225 hybrid_clock.cc:648] HybridClock initialized: now 1786458525931780 us; error 28 us; skew 500 ppm
14:28:45.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.946213  1225 webserver.cc:460] Webserver started at http://127.1.46.62:42913/ using document root <none> and password file <none>
14:28:45.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.946498  1225 fs_manager.cc:359] Metadata directory not provided
14:28:45.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.946544  1225 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:28:45.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.946628  1225 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
14:28:45.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.947535  1225 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/data/instance:
14:28:45.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fc99746be1244a8eb7a1124ed40325fa"
14:28:45.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:45 on dist-test-slave-fgb3"
14:28:45.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.947840  1225 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/wal/instance:
14:28:45.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fc99746be1244a8eb7a1124ed40325fa"
14:28:45.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:45 on dist-test-slave-fgb3"
14:28:45.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.949034  1225 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.001s	sys 0.001s
14:28:45.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.949757  1257 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:28:45.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.949903  1225 fs_manager.cc:725] Time spent opening block manager: real 0.000s	user 0.000s	sys 0.000s
14:28:45.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.949966  1225 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/data,/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/wal
14:28:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fc99746be1244a8eb7a1124ed40325fa"
14:28:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:45 on dist-test-slave-fgb3"
14:28:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.950013  1225 fs_report.cc:383] FS layout report
14:28:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:28:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/wal
14:28:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/wal
14:28:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/data/data
14:28:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:28:45.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:28:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:28:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:28:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:28:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:28:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:28:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:28:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:28:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:28:45.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:28:45.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.970060  1225 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
14:28:45.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.970289  1225 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:28:45.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.970407  1225 kserver.cc:163] Server-wide thread pool size limit: 3276
14:28:45.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.974115  1225 rpc_server.cc:307] RPC server started. Bound to: 127.1.46.62:34223
14:28:45.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.974153  1347 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.1.46.62:34223 every 8 connection(s)
14:28:45.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.974440  1225 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/data/info.pb
14:28:45.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.975020  1208 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskdU6HUy/build/release/bin/kudu as pid 1225
14:28:45.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.975113  1208 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-0/wal/instance
14:28:45.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.975135  1348 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:28:45.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.975965  1208 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:45.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:45.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/wal
14:28:45.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/data
14:28:45.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:28:45.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:28:45.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:28:45.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:45.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:45.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:45.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/logs
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/data/info.pb
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:28:45.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:28:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.61:41403
14:28:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.61
14:28:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:28:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:28:45.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45219/jwks.json with env {}
14:28:45.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.977072  1348 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } has no permanent_uuid. Determining permanent_uuid...
14:28:45.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.984053  1348 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } has no permanent_uuid. Determining permanent_uuid...
14:28:45.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.984526  1265 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.1.46.61:41403: connect: Connection refused (error 111)
14:28:45.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:45.985020  1348 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.1.46.61:41403: Network error: Client connection negotiation failed: client connection to 127.1.46.61:41403: connect: Connection refused (error 111)
14:28:46.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.034258  1348 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } attempt: 1
14:28:46.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.037896  1348 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.1.46.61:41403: Network error: Client connection negotiation failed: client connection to 127.1.46.61:41403: connect: Connection refused (error 111)
14:28:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.060573  1353 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
14:28:46.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.060770  1353 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:28:46.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.060788  1353 flags.cc:425] Enabled unsafe flag: --never_fsync=true
14:28:46.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.062071  1353 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
14:28:46.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.062116  1353 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
14:28:46.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.062129  1353 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
14:28:46.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.062140  1353 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
14:28:46.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.062152  1353 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
14:28:46.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.062162  1353 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45219/jwks.json
14:28:46.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.064079  1353 master_runner.cc:386] Master server non-default flags:
14:28:46.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:46.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:46.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/data
14:28:46.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/wal
14:28:46.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:28:46.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.61:41403
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45219/jwks.json
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/data/info.pb
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.61
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.1353
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:28:46.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:28:46.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/logs
14:28:46.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:28:46.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:28:46.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:28:46.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
14:28:46.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
14:28:46.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:28:46.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:41:36 UTC on ccycloud.quasar-ebruqk.root.comops.site
14:28:46.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580675
14:28:46.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.064364  1353 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:28:46.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.064708  1353 file_cache.cc:493] Constructed file cache file cache with capacity 419430
14:28:46.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.069989  1373 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:28:46.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.070024  1376 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:28:46.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.070235  1353 server_base.cc:1034] running on GCE node
14:28:46.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.070025  1372 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:28:46.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.070585  1353 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:28:46.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.070897  1353 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:28:46.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.072036  1353 hybrid_clock.cc:648] HybridClock initialized: now 1786458526072032 us; error 31 us; skew 500 ppm
14:28:46.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.073156  1353 webserver.cc:460] Webserver started at http://127.1.46.61:38435/ using document root <none> and password file <none>
14:28:46.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.073341  1353 fs_manager.cc:359] Metadata directory not provided
14:28:46.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.073374  1353 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:28:46.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.073486  1353 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
14:28:46.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.074398  1353 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/data/instance:
14:28:46.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "007ec6863c8b423a9a0845c2fd58e556"
14:28:46.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.074697  1353 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/wal/instance:
14:28:46.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "007ec6863c8b423a9a0845c2fd58e556"
14:28:46.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.075919  1353 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.001s	sys 0.000s
14:28:46.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.076628  1387 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:28:46.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.076787  1353 fs_manager.cc:725] Time spent opening block manager: real 0.000s	user 0.001s	sys 0.000s
14:28:46.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.076874  1353 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/data,/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/wal
14:28:46.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "007ec6863c8b423a9a0845c2fd58e556"
14:28:46.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.076938  1353 fs_report.cc:383] FS layout report
14:28:46.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:28:46.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/wal
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/wal
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/data/data
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:28:46.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:28:46.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:28:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.090301  1353 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
14:28:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.090595  1353 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:28:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.090685  1353 kserver.cc:163] Server-wide thread pool size limit: 3276
14:28:46.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.094336  1353 rpc_server.cc:307] RPC server started. Bound to: 127.1.46.61:41403
14:28:46.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.094378  1480 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.1.46.61:41403 every 8 connection(s)
14:28:46.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.094750  1353 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/data/info.pb
14:28:46.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.095443  1486 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:28:46.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.097265  1486 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } has no permanent_uuid. Determining permanent_uuid...
14:28:46.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.101137  1208 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskdU6HUy/build/release/bin/kudu as pid 1353
14:28:46.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.101217  1208 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-1/wal/instance
14:28:46.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.101572  1208 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:46.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:46.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/wal
14:28:46.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/data
14:28:46.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:28:46.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:28:46.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:28:46.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/logs
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/data/info.pb
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.60:40065
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.60
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:28:46.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:46.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:28:46.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45219/jwks.json with env {}
14:28:46.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.102167  1486 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } has no permanent_uuid. Determining permanent_uuid...
14:28:46.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.106055  1348 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } attempt: 2
14:28:46.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.107136  1486 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } has no permanent_uuid. Determining permanent_uuid...
14:28:46.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.107517  1389 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.1.46.60:40065: connect: Connection refused (error 111)
14:28:46.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.110050  1486 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.1.46.60:40065: Network error: Client connection negotiation failed: client connection to 127.1.46.60:40065: connect: Connection refused (error 111)
14:28:46.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.110813  1348 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } has no permanent_uuid. Determining permanent_uuid...
14:28:46.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.111368  1348 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.1.46.60:40065: Network error: Client connection negotiation failed: client connection to 127.1.46.60:40065: connect: Connection refused (error 111)
14:28:46.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.154493  1348 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } attempt: 1
14:28:46.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.155249  1348 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.1.46.60:40065: Network error: Client connection negotiation failed: client connection to 127.1.46.60:40065: connect: Connection refused (error 111)
14:28:46.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.159243  1486 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } attempt: 1
14:28:46.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.159859  1486 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.1.46.60:40065: Network error: Client connection negotiation failed: client connection to 127.1.46.60:40065: connect: Connection refused (error 111)
14:28:46.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.186064  1493 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
14:28:46.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.186251  1493 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:28:46.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.186270  1493 flags.cc:425] Enabled unsafe flag: --never_fsync=true
14:28:46.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.187422  1493 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
14:28:46.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.187462  1493 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
14:28:46.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.187481  1493 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
14:28:46.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.187492  1493 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
14:28:46.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.187502  1493 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
14:28:46.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.187512  1493 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45219/jwks.json
14:28:46.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.188815  1493 master_runner.cc:386] Master server non-default flags:
14:28:46.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/data
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/wal
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.60:40065
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45219/jwks.json
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/data/info.pb
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.60
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.1493
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/logs
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:28:46.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:28:46.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:28:46.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
14:28:46.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
14:28:46.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:28:46.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:41:36 UTC on ccycloud.quasar-ebruqk.root.comops.site
14:28:46.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580675
14:28:46.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.189004  1493 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:28:46.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.189224  1493 file_cache.cc:493] Constructed file cache file cache with capacity 419430
14:28:46.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.194198  1508 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:28:46.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.194409  1493 server_base.cc:1034] running on GCE node
14:28:46.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.194213  1511 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:28:46.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.194252  1507 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:28:46.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.195430  1493 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:28:46.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.195762  1493 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:28:46.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.196921  1493 hybrid_clock.cc:648] HybridClock initialized: now 1786458526196902 us; error 35 us; skew 500 ppm
14:28:46.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.198374  1493 webserver.cc:460] Webserver started at http://127.1.46.60:40249/ using document root <none> and password file <none>
14:28:46.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.198628  1493 fs_manager.cc:359] Metadata directory not provided
14:28:46.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.198690  1493 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:28:46.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.198822  1493 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
14:28:46.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.200049  1493 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/data/instance:
14:28:46.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "46bdbd66dd8c4df9a157328851c44e9e"
14:28:46.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.200481  1493 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/wal/instance:
14:28:46.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "46bdbd66dd8c4df9a157328851c44e9e"
14:28:46.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.202093  1493 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
14:28:46.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.202366  1348 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } attempt: 2
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.202988  1523 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.203127  1348 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.1.46.60:40065: Network error: Client connection negotiation failed: client connection to 127.1.46.60:40065: connect: Connection refused (error 111)
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.203253  1493 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.000s
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.203346  1493 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/data,/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/wal
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "46bdbd66dd8c4df9a157328851c44e9e"
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.203408  1493 fs_report.cc:383] FS layout report
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/wal
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/wal
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/data/data
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:28:46.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:28:46.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.217125  1493 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
14:28:46.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.217443  1493 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:28:46.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.217582  1493 kserver.cc:163] Server-wide thread pool size limit: 3276
14:28:46.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.222452  1493 rpc_server.cc:307] RPC server started. Bound to: 127.1.46.60:40065
14:28:46.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.222481  1620 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.1.46.60:40065 every 8 connection(s)
14:28:46.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.222859  1493 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/data/info.pb
14:28:46.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.223599  1621 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:28:46.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.225538  1621 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } has no permanent_uuid. Determining permanent_uuid...
14:28:46.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.227545  1208 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskdU6HUy/build/release/bin/kudu as pid 1493
14:28:46.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.227617  1208 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/master-2/wal/instance
14:28:46.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.228010  1486 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } attempt: 2
14:28:46.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.231251  1621 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } has no permanent_uuid. Determining permanent_uuid...
14:28:46.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.234058  1486 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556: Bootstrap starting.
14:28:46.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.234841  1486 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556: Neither blocks nor log segments found. Creating new log.
14:28:46.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.235224  1486 log.cc:824] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556: Log is configured to *not* fsync() on all Append() calls
14:28:46.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.235308  1621 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } has no permanent_uuid. Determining permanent_uuid...
14:28:46.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.236222  1486 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556: No bootstrap required, opened a new log
14:28:46.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.238400  1486 raft_consensus.cc:348] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } }
14:28:46.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.238545  1486 raft_consensus.cc:374] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:28:46.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.238590  1486 raft_consensus.cc:729] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 007ec6863c8b423a9a0845c2fd58e556, State: Initialized, Role: FOLLOWER
14:28:46.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.238699  1486 consensus_queue.cc:260] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [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: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } }
14:28:46.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.238935  1635 sys_catalog.cc:455] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } } }
14:28:46.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.238998  1486 sys_catalog.cc:564] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [sys.catalog]: configured and running, proceeding with master startup.
14:28:46.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.239006  1635 sys_catalog.cc:458] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [sys.catalog]: This master's current role is: FOLLOWER
14:28:46.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.241175  1649 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:28:46.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.241236  1649 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:28:46.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.243983  1621 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e: Bootstrap starting.
14:28:46.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.244673  1621 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e: Neither blocks nor log segments found. Creating new log.
14:28:46.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.245011  1621 log.cc:824] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e: Log is configured to *not* fsync() on all Append() calls
14:28:46.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.242950  1353 master_runner.cc:186] Error getting master registration for 127.1.46.62:34223: OK, instance_id { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" instance_seqno: 1786458525973199 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:28:46.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.245335  1353 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
14:28:46.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.246835  1621 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e: No bootstrap required, opened a new log
14:28:46.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.249035  1621 raft_consensus.cc:348] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } }
14:28:46.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.249182  1621 raft_consensus.cc:374] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:28:46.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.249212  1621 raft_consensus.cc:729] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 46bdbd66dd8c4df9a157328851c44e9e, State: Initialized, Role: FOLLOWER
14:28:46.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.249312  1621 consensus_queue.cc:260] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [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: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } }
14:28:46.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.249598  1621 sys_catalog.cc:564] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [sys.catalog]: configured and running, proceeding with master startup.
14:28:46.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.249825  1653 sys_catalog.cc:455] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } } }
14:28:46.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.254395  1653 sys_catalog.cc:458] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [sys.catalog]: This master's current role is: FOLLOWER
14:28:46.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.254913  1493 master_runner.cc:186] Error getting master registration for 127.1.46.62:34223: OK, instance_id { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" instance_seqno: 1786458525973199 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:28:46.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.257081  1493 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
14:28:46.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.258811  1671 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:28:46.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.258855  1671 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:28:46.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.310284  1348 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } attempt: 3
14:28:46.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.315622  1348 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa: Bootstrap starting.
14:28:46.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.316449  1348 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa: Neither blocks nor log segments found. Creating new log.
14:28:46.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.316802  1348 log.cc:824] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa: Log is configured to *not* fsync() on all Append() calls
14:28:46.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.317934  1348 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa: No bootstrap required, opened a new log
14:28:46.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.320119  1348 raft_consensus.cc:348] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } }
14:28:46.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.320266  1348 raft_consensus.cc:374] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:28:46.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.320303  1348 raft_consensus.cc:729] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: fc99746be1244a8eb7a1124ed40325fa, State: Initialized, Role: FOLLOWER
14:28:46.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.320439  1348 consensus_queue.cc:260] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [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: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } }
14:28:46.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.320766  1348 sys_catalog.cc:564] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [sys.catalog]: configured and running, proceeding with master startup.
14:28:46.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.320832  1679 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } } }
14:28:46.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.321266  1679 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [sys.catalog]: This master's current role is: FOLLOWER
14:28:46.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.322861  1695 catalog_manager.cc:1558] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:28:46.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.323084  1695 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:28:46.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.324854  1225 master_runner.cc:263] No leader master found from master fc99746be1244a8eb7a1124ed40325fa
14:28:46.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.324899  1225 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
14:28:46.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.329713  1679 raft_consensus.cc:482] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:28:46.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.329810  1679 raft_consensus.cc:504] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } }
14:28:46.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.330024  1679 leader_election.cc:288] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 007ec6863c8b423a9a0845c2fd58e556 (127.1.46.61:41403), 46bdbd66dd8c4df9a157328851c44e9e (127.1.46.60:40065)
14:28:46.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.331384  1428 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc99746be1244a8eb7a1124ed40325fa" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "007ec6863c8b423a9a0845c2fd58e556" is_pre_election: true
14:28:46.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.331528  1428 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate fc99746be1244a8eb7a1124ed40325fa in term 0.
14:28:46.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.331817  1265 leader_election.cc:302] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [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: 007ec6863c8b423a9a0845c2fd58e556, fc99746be1244a8eb7a1124ed40325fa; no voters: 
14:28:46.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.331945  1679 raft_consensus.cc:2781] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [term 0 FOLLOWER]: Leader pre-election won for term 1
14:28:46.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.332007  1679 raft_consensus.cc:482] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:28:46.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.332031  1679 raft_consensus.cc:3037] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [term 0 FOLLOWER]: Advancing to term 1
14:28:46.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.332881  1679 raft_consensus.cc:504] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } }
14:28:46.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.333012  1679 leader_election.cc:288] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [CANDIDATE]: Term 1 election: Requested vote from peers 007ec6863c8b423a9a0845c2fd58e556 (127.1.46.61:41403), 46bdbd66dd8c4df9a157328851c44e9e (127.1.46.60:40065)
14:28:46.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.333287  1567 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc99746be1244a8eb7a1124ed40325fa" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "46bdbd66dd8c4df9a157328851c44e9e"
14:28:46.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.333400  1567 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [term 0 FOLLOWER]: Advancing to term 1
14:28:46.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.334183  1567 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate fc99746be1244a8eb7a1124ed40325fa in term 1.
14:28:46.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.334363  1568 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc99746be1244a8eb7a1124ed40325fa" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "46bdbd66dd8c4df9a157328851c44e9e" is_pre_election: true
14:28:46.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.334438  1568 raft_consensus.cc:2362] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [term 1 FOLLOWER]: Leader pre-election vote request: Already granted yes vote for candidate fc99746be1244a8eb7a1124ed40325fa in term 1. Re-sending same reply.
14:28:46.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.334690  1428 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "fc99746be1244a8eb7a1124ed40325fa" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "007ec6863c8b423a9a0845c2fd58e556"
14:28:46.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.334779  1428 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [term 0 FOLLOWER]: Advancing to term 1
14:28:46.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.335582  1428 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate fc99746be1244a8eb7a1124ed40325fa in term 1.
14:28:46.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.335757  1259 leader_election.cc:302] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [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: 46bdbd66dd8c4df9a157328851c44e9e, fc99746be1244a8eb7a1124ed40325fa; no voters: 
14:28:46.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.341228  1393 tablet.cc:2369] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:28:46.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.346385  1679 raft_consensus.cc:2781] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [term 1 FOLLOWER]: Leader election won for term 1
14:28:46.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.346577  1679 raft_consensus.cc:686] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [term 1 LEADER]: Becoming Leader. State: Replica: fc99746be1244a8eb7a1124ed40325fa, State: Running, Role: LEADER
14:28:46.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.346683  1679 consensus_queue.cc:237] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [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: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } }
14:28:46.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.347112  1679 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [sys.catalog]: SysCatalogTable state changed. Reason: New leader fc99746be1244a8eb7a1124ed40325fa. Latest consensus state: current_term: 1 leader_uuid: "fc99746be1244a8eb7a1124ed40325fa" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } } }
14:28:46.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.347190  1679 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [sys.catalog]: This master's current role is: LEADER
14:28:46.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.351227  1701 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
14:28:46.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.351693  1701 catalog_manager.cc:1484] Initializing Kudu cluster ID...
14:28:46.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.354171  1568 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [term 1 FOLLOWER]: Refusing update from remote peer fc99746be1244a8eb7a1124ed40325fa: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:28:46.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.354696  1679 consensus_queue.cc:1035] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [LEADER]: Connected to new peer: Peer: permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:28:46.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.356775  1653 sys_catalog.cc:455] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [sys.catalog]: SysCatalogTable state changed. Reason: New leader fc99746be1244a8eb7a1124ed40325fa. Latest consensus state: current_term: 1 leader_uuid: "fc99746be1244a8eb7a1124ed40325fa" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } } }
14:28:46.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.356881  1653 sys_catalog.cc:458] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [sys.catalog]: This master's current role is: FOLLOWER
14:28:46.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.360617  1428 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [term 1 FOLLOWER]: Refusing update from remote peer fc99746be1244a8eb7a1124ed40325fa: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:28:46.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.360867  1679 consensus_queue.cc:1035] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [LEADER]: Connected to new peer: Peer: permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:28:46.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.361954  1635 sys_catalog.cc:455] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [sys.catalog]: SysCatalogTable state changed. Reason: New leader fc99746be1244a8eb7a1124ed40325fa. Latest consensus state: current_term: 1 leader_uuid: "fc99746be1244a8eb7a1124ed40325fa" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } } }
14:28:46.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.362047  1635 sys_catalog.cc:458] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [sys.catalog]: This master's current role is: FOLLOWER
14:28:46.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.374861  1699 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "fc99746be1244a8eb7a1124ed40325fa" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } } }
14:28:46.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.374977  1699 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [sys.catalog]: This master's current role is: LEADER
14:28:46.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.375873  1635 sys_catalog.cc:455] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "fc99746be1244a8eb7a1124ed40325fa" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } } }
14:28:46.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.375953  1635 sys_catalog.cc:458] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556 [sys.catalog]: This master's current role is: FOLLOWER
14:28:46.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.376827  1703 mvcc.cc:205] Tried to move back new op lower bound from 7317334123944321024 to 7317334123916648448. Current Snapshot: MvccSnapshot[applied={T|T < 7317334123944321024}]
14:28:46.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.378077  1709 mvcc.cc:205] Tried to move back new op lower bound from 7317334123944321024 to 7317334123916648448. Current Snapshot: MvccSnapshot[applied={T|T < 7317334123944321024}]
14:28:46.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.379068  1679 sys_catalog.cc:455] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "fc99746be1244a8eb7a1124ed40325fa" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } } }
14:28:46.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.379184  1679 sys_catalog.cc:458] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa [sys.catalog]: This master's current role is: LEADER
14:28:46.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.379561  1653 sys_catalog.cc:455] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "fc99746be1244a8eb7a1124ed40325fa" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "fc99746be1244a8eb7a1124ed40325fa" member_type: VOTER last_known_addr { host: "127.1.46.62" port: 34223 } } peers { permanent_uuid: "007ec6863c8b423a9a0845c2fd58e556" member_type: VOTER last_known_addr { host: "127.1.46.61" port: 41403 } } peers { permanent_uuid: "46bdbd66dd8c4df9a157328851c44e9e" member_type: VOTER last_known_addr { host: "127.1.46.60" port: 40065 } } }
14:28:46.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.379660  1653 sys_catalog.cc:458] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e [sys.catalog]: This master's current role is: FOLLOWER
14:28:46.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.381583  1706 mvcc.cc:205] Tried to move back new op lower bound from 7317334123944321024 to 7317334123916648448. Current Snapshot: MvccSnapshot[applied={T|T < 7317334123944321024}]
14:28:46.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.382673  1701 catalog_manager.cc:1347] Generated new cluster ID: 4cc5d952351c494f9ba3ca0ec7db90d9
14:28:46.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.382723  1701 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
14:28:46.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.400806  1701 catalog_manager.cc:1370] Generated new certificate authority record
14:28:46.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.401674  1701 catalog_manager.cc:1504] Loading token signing keys...
14:28:46.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.415812  1701 catalog_manager.cc:5868] T 00000000000000000000000000000000 P fc99746be1244a8eb7a1124ed40325fa: Generated new TSK 0
14:28:46.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.416316  1701 catalog_manager.cc:1514] Initializing in-progress tserver states...
14:28:46.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.419819  1208 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/wal
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/data
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/logs
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/data/info.pb
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.1:0
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.46.1
14:28:46.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.1
14:28:46.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:46.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:46.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:28:46.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.506564  1716 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
14:28:46.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.506775  1716 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:28:46.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.506805  1716 flags.cc:425] Enabled unsafe flag: --never_fsync=true
14:28:46.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.508142  1716 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
14:28:46.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.508205  1716 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.1.46.1
14:28:46.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.509668  1716 tablet_server_runner.cc:78] Tablet server non-default flags:
14:28:46.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:46.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:46.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/data
14:28:46.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/wal
14:28:46.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.1:0
14:28:46.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/data/info.pb
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.1
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.1716
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.46.1
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/logs
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
14:28:46.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
14:28:46.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:28:46.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:41:36 UTC on ccycloud.quasar-ebruqk.root.comops.site
14:28:46.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580675
14:28:46.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.509910  1716 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:28:46.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.510262  1716 file_cache.cc:493] Constructed file cache file cache with capacity 419430
14:28:46.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.516615  1729 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:28:46.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.516685  1724 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:28:46.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.516618  1725 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:28:46.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.516966  1716 server_base.cc:1034] running on GCE node
14:28:46.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.517163  1716 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:28:46.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.517431  1716 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:28:46.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.518582  1716 hybrid_clock.cc:648] HybridClock initialized: now 1786458526518565 us; error 31 us; skew 500 ppm
14:28:46.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.519793  1716 webserver.cc:460] Webserver started at http://127.1.46.1:32901/ using document root <none> and password file <none>
14:28:46.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.520056  1716 fs_manager.cc:359] Metadata directory not provided
14:28:46.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.520131  1716 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:28:46.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.520265  1716 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
14:28:46.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.521255  1716 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/data/instance:
14:28:46.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c78c5b7e3482475b8c8af7f63690b6f7"
14:28:46.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.521606  1716 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/wal/instance:
14:28:46.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c78c5b7e3482475b8c8af7f63690b6f7"
14:28:46.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.523015  1716 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
14:28:46.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.523736  1738 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.523916  1716 fs_manager.cc:725] Time spent opening block manager: real 0.000s	user 0.001s	sys 0.000s
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.524012  1716 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/data,/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/wal
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c78c5b7e3482475b8c8af7f63690b6f7"
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.524082  1716 fs_report.cc:383] FS layout report
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/wal
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/wal
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/data/data
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:28:46.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:28:46.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:28:46.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:28:46.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:28:46.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.535856  1716 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
14:28:46.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.536073  1716 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:28:46.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.536155  1716 kserver.cc:163] Server-wide thread pool size limit: 3276
14:28:46.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.536307  1716 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
14:28:46.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.536566  1716 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:28:46.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.536598  1716 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:28:46.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.536617  1716 ts_tablet_manager.cc:610] Registered 0 tablets
14:28:46.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.536628  1716 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:28:46.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.542292  1716 rpc_server.cc:307] RPC server started. Bound to: 127.1.46.1:35355
14:28:46.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.542372  1928 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.1.46.1:35355 every 8 connection(s)
14:28:46.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.542711  1716 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/data/info.pb
14:28:46.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.548488  1931 heartbeater.cc:347] Connected to a master server at 127.1.46.61:41403
14:28:46.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.548557  1930 heartbeater.cc:347] Connected to a master server at 127.1.46.60:40065
14:28:46.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.548780  1930 heartbeater.cc:464] Registering TS with master...
14:28:46.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.548780  1931 heartbeater.cc:464] Registering TS with master...
14:28:46.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.548902  1208 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskdU6HUy/build/release/bin/kudu as pid 1716
14:28:46.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.549001  1208 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-0/wal/instance
14:28:46.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.548991  1930 heartbeater.cc:511] Master 127.1.46.60:40065 requested a full tablet report, sending...
14:28:46.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.548991  1931 heartbeater.cc:511] Master 127.1.46.61:41403 requested a full tablet report, sending...
14:28:46.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.548575  1929 heartbeater.cc:347] Connected to a master server at 127.1.46.62:34223
14:28:46.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.549382  1929 heartbeater.cc:464] Registering TS with master...
14:28:46.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.549471  1929 heartbeater.cc:511] Master 127.1.46.62:34223 requested a full tablet report, sending...
14:28:46.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.549526  1549 ts_manager.cc:194] Registered new tserver with Master: c78c5b7e3482475b8c8af7f63690b6f7 (127.1.46.1:35355)
14:28:46.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.549526  1411 ts_manager.cc:194] Registered new tserver with Master: c78c5b7e3482475b8c8af7f63690b6f7 (127.1.46.1:35355)
14:28:46.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.549811  1287 ts_manager.cc:194] Registered new tserver with Master: c78c5b7e3482475b8c8af7f63690b6f7 (127.1.46.1:35355)
14:28:46.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.550369  1208 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:46.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:46.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/wal
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/data
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/logs
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/data/info.pb
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.2:0
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.46.2
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.2
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:46.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:46.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:28:46.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.550680  1287 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.1.46.1:35425
14:28:46.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.636950  1938 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
14:28:46.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.637142  1938 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:28:46.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.637161  1938 flags.cc:425] Enabled unsafe flag: --never_fsync=true
14:28:46.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.638233  1938 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
14:28:46.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.638278  1938 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.1.46.2
14:28:46.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.639717  1938 tablet_server_runner.cc:78] Tablet server non-default flags:
14:28:46.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/data
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/wal
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.2:0
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/data/info.pb
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.2
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.1938
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.46.2
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/logs
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:41:36 UTC on ccycloud.quasar-ebruqk.root.comops.site
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580675
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.639909  1938 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:28:46.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.640192  1938 file_cache.cc:493] Constructed file cache file cache with capacity 419430
14:28:46.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.645133  1946 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:28:46.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.645124  1949 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:28:46.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.645243  1953 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:28:46.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.645268  1938 server_base.cc:1034] running on GCE node
14:28:46.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.645696  1938 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:28:46.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.645942  1938 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:28:46.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.647100  1938 hybrid_clock.cc:648] HybridClock initialized: now 1786458526647079 us; error 33 us; skew 500 ppm
14:28:46.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.648433  1938 webserver.cc:460] Webserver started at http://127.1.46.2:46809/ using document root <none> and password file <none>
14:28:46.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.648624  1938 fs_manager.cc:359] Metadata directory not provided
14:28:46.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.648663  1938 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:28:46.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.648748  1938 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
14:28:46.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.649645  1938 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/data/instance:
14:28:46.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eb07dc6907ff4221944484768a1d88a9"
14:28:46.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.649992  1938 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/wal/instance:
14:28:46.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eb07dc6907ff4221944484768a1d88a9"
14:28:46.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.651214  1938 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
14:28:46.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.651849  1961 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.651983  1938 fs_manager.cc:725] Time spent opening block manager: real 0.000s	user 0.001s	sys 0.000s
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.652047  1938 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/data,/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/wal
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eb07dc6907ff4221944484768a1d88a9"
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.652088  1938 fs_report.cc:383] FS layout report
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/wal
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/wal
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/data/data
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:28:46.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.663003  1938 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.663219  1938 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.663300  1938 kserver.cc:163] Server-wide thread pool size limit: 3276
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.663468  1938 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.663795  1938 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.663830  1938 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:28:46.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.663857  1938 ts_tablet_manager.cc:610] Registered 0 tablets
14:28:46.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.663873  1938 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:28:46.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.669896  1938 rpc_server.cc:307] RPC server started. Bound to: 127.1.46.2:43995
14:28:46.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.669934  2150 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.1.46.2:43995 every 8 connection(s)
14:28:46.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.670258  1938 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/data/info.pb
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.675668  1208 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskdU6HUy/build/release/bin/kudu as pid 1938
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.675750  1208 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-1/wal/instance
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.675884  2153 heartbeater.cc:347] Connected to a master server at 127.1.46.60:40065
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.675925  2154 heartbeater.cc:347] Connected to a master server at 127.1.46.61:41403
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.675973  2154 heartbeater.cc:464] Registering TS with master...
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.675973  2153 heartbeater.cc:464] Registering TS with master...
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.676162  2154 heartbeater.cc:511] Master 127.1.46.61:41403 requested a full tablet report, sending...
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.676608  1411 ts_manager.cc:194] Registered new tserver with Master: eb07dc6907ff4221944484768a1d88a9 (127.1.46.2:43995)
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.676970  2151 heartbeater.cc:347] Connected to a master server at 127.1.46.62:34223
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.677105  1208 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskdU6HUy/build/release/bin/kudu
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/wal
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/data
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/logs
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/data/info.pb
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.3:0
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.46.3
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.3
14:28:46.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:46.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:46.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:28:46.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.676162  2153 heartbeater.cc:511] Master 127.1.46.60:40065 requested a full tablet report, sending...
14:28:46.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.677163  2151 heartbeater.cc:464] Registering TS with master...
14:28:46.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.677232  2151 heartbeater.cc:511] Master 127.1.46.62:34223 requested a full tablet report, sending...
14:28:46.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.677386  1549 ts_manager.cc:194] Registered new tserver with Master: eb07dc6907ff4221944484768a1d88a9 (127.1.46.2:43995)
14:28:46.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.677562  1287 ts_manager.cc:194] Registered new tserver with Master: eb07dc6907ff4221944484768a1d88a9 (127.1.46.2:43995)
14:28:46.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.677908  1287 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.1.46.2:56071
14:28:46.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.759660  2165 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
14:28:46.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.759852  2165 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:28:46.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.759871  2165 flags.cc:425] Enabled unsafe flag: --never_fsync=true
14:28:46.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.760929  2165 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
14:28:46.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.760972  2165 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.1.46.3
14:28:46.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.762254  2165 tablet_server_runner.cc:78] Tablet server non-default flags:
14:28:46.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.46.20:44409
14:28:46.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:46.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/data
14:28:46.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/wal
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.46.3:0
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/data/info.pb
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.46.3
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.46.62:34223,127.1.46.61:41403,127.1.46.60:40065
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.2165
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.46.3
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/logs
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:41:36 UTC on ccycloud.quasar-ebruqk.root.comops.site
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580675
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.762462  2165 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:28:46.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.762684  2165 file_cache.cc:493] Constructed file cache file cache with capacity 419430
14:28:46.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.767532  2165 server_base.cc:1034] running on GCE node
14:28:46.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.767540  2175 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:28:46.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.767553  2177 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:28:46.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.767584  2174 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:28:46.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.767998  2165 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:28:46.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.768266  2165 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:28:46.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.769424  2165 hybrid_clock.cc:648] HybridClock initialized: now 1786458526769403 us; error 30 us; skew 500 ppm
14:28:46.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.770643  2165 webserver.cc:460] Webserver started at http://127.1.46.3:35989/ using document root <none> and password file <none>
14:28:46.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.770869  2165 fs_manager.cc:359] Metadata directory not provided
14:28:46.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.770932  2165 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:28:46.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.771088  2165 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
14:28:46.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.772032  2165 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/data/instance:
14:28:46.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bda51bf553914065af471adc3ff40f1b"
14:28:46.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.772392  2165 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/wal/instance:
14:28:46.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bda51bf553914065af471adc3ff40f1b"
14:28:46.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.773681  2165 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
14:28:46.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.774477  2187 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:28:46.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.774613  2165 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:28:46.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.774688  2165 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/data,/tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/wal
14:28:46.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bda51bf553914065af471adc3ff40f1b"
14:28:46.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-fgb3"
14:28:46.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.774736  2165 fs_report.cc:383] FS layout report
14:28:46.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:28:46.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/wal
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/wal
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/data/data
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:28:46.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:28:46.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.788573  2165 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
14:28:46.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.788792  2165 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:28:46.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.788880  2165 kserver.cc:163] Server-wide thread pool size limit: 3276
14:28:46.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.789063  2165 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
14:28:46.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.789410  2165 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:28:46.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.789458  2165 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:28:46.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.789484  2165 ts_tablet_manager.cc:610] Registered 0 tablets
14:28:46.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.789500  2165 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:28:46.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.795480  2165 rpc_server.cc:307] RPC server started. Bound to: 127.1.46.3:42121
14:28:46.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.795540  2373 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.1.46.3:42121 every 8 connection(s)
14:28:46.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.795789  2165 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/data/info.pb
14:28:46.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.801677  2377 heartbeater.cc:347] Connected to a master server at 127.1.46.61:41403
14:28:46.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.801677  2374 heartbeater.cc:347] Connected to a master server at 127.1.46.62:34223
14:28:46.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.801987  2377 heartbeater.cc:464] Registering TS with master...
14:28:46.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.801990  2374 heartbeater.cc:464] Registering TS with master...
14:28:46.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.802000  1208 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskdU6HUy/build/release/bin/kudu as pid 2165
14:28:46.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.802078  1208 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskdU6HUy/test-tmp/mini-kudu-cluster8861291838357752260/ts-2/wal/instance
14:28:46.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.802204  2377 heartbeater.cc:511] Master 127.1.46.61:41403 requested a full tablet report, sending...
14:28:46.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.802205  2374 heartbeater.cc:511] Master 127.1.46.62:34223 requested a full tablet report, sending...
14:28:46.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.802654  1287 ts_manager.cc:194] Registered new tserver with Master: bda51bf553914065af471adc3ff40f1b (127.1.46.3:42121)
14:28:46.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.803134  1287 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.1.46.3:49091
14:28:46.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.803342  1405 ts_manager.cc:194] Registered new tserver with Master: bda51bf553914065af471adc3ff40f1b (127.1.46.3:42121)
14:28:46.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.801864  2376 heartbeater.cc:347] Connected to a master server at 127.1.46.60:40065
14:28:46.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.803705  2376 heartbeater.cc:464] Registering TS with master...
14:28:46.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.803877  2376 heartbeater.cc:511] Master 127.1.46.60:40065 requested a full tablet report, sending...
14:28:46.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.804164  1549 ts_manager.cc:194] Registered new tserver with Master: bda51bf553914065af471adc3ff40f1b (127.1.46.3:42121)
14:28:46.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.805258  1208 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
14:28:46.806 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:28:46.807 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

14:28:46.815 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.1.46.62"
      port: 34223
    }
    bound_http_address {
      host: "127.1.46.62"
      port: 42913
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.1.46.61"
      port: 41403
    }
    bound_http_address {
      host: "127.1.46.61"
      port: 38435
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.1.46.60"
      port: 40065
    }
    bound_http_address {
      host: "127.1.46.60"
      port: 40249
    }
  }
}

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

14:28:46.824 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.1.46.1"
      port: 35355
    }
    bound_http_address {
      host: "127.1.46.1"
      port: 32901
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.1.46.2"
      port: 43995
    }
    bound_http_address {
      host: "127.1.46.2"
      port: 46809
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.1.46.3"
      port: 42121
    }
    bound_http_address {
      host: "127.1.46.3"
      port: 35989
    }
  }
}

14:28:46.827 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
14:28:46.837 [DEBUG - main] (InternalLoggerFactory.java:63) Using SLF4J as the default logging framework
14:28:46.842 [DEBUG - main] (ResourceLeakDetector.java:129) -Dorg.apache.kudu.shaded.io.netty.leakDetection.level: simple
14:28:46.842 [DEBUG - main] (ResourceLeakDetector.java:130) -Dorg.apache.kudu.shaded.io.netty.leakDetection.targetRecords: 4
14:28:46.847 [DEBUG - main] (ResourceLeakDetectorFactory.java:196) Loaded default ResourceLeakDetector: org.apache.kudu.shaded.io.netty.util.ResourceLeakDetector@68044f4
14:28:46.865 [DEBUG - main] (PlatformDependent0.java:497) -Dio.netty.noUnsafe: false
14:28:46.865 [DEBUG - main] (PlatformDependent0.java:1001) Java version: 8
14:28:46.866 [DEBUG - main] (PlatformDependent0.java:137) sun.misc.Unsafe.theUnsafe: available
14:28:46.867 [DEBUG - main] (PlatformDependent0.java:161) sun.misc.Unsafe.copyMemory: available
14:28:46.867 [DEBUG - main] (PlatformDependent0.java:193) sun.misc.Unsafe.storeFence: available
14:28:46.867 [DEBUG - main] (PlatformDependent0.java:236) java.nio.Buffer.address: available
14:28:46.868 [DEBUG - main] (PlatformDependent0.java:308) direct buffer constructor: available
14:28:46.868 [DEBUG - main] (PlatformDependent0.java:386) java.nio.Bits.unaligned: available, true
14:28:46.869 [DEBUG - main] (PlatformDependent0.java:460) jdk.internal.misc.Unsafe.allocateUninitializedArray(int): unavailable prior to Java9
14:28:46.869 [DEBUG - main] (PlatformDependent0.java:483) java.nio.DirectByteBuffer.<init>(long, {int,long}): available
14:28:46.869 [DEBUG - main] (PlatformDependent.java:1159) sun.misc.Unsafe: available
14:28:46.869 [DEBUG - main] (PlatformDependent.java:1289) -Dio.netty.tmpdir: /tmp (java.io.tmpdir)
14:28:46.869 [DEBUG - main] (PlatformDependent.java:1368) -Dio.netty.bitMode: 64 (sun.arch.data.model)
14:28:46.870 [DEBUG - main] (PlatformDependent.java:178) -Dio.netty.maxDirectMemory: 3799121920 bytes
14:28:46.870 [DEBUG - main] (PlatformDependent.java:185) -Dio.netty.uninitializedArrayAllocationThreshold: -1
14:28:46.871 [DEBUG - main] (CleanerJava6.java:92) java.nio.ByteBuffer.cleaner(): available
14:28:46.871 [DEBUG - main] (PlatformDependent.java:205) -Dio.netty.noPreferDirect: false
14:28:46.879 [DEBUG - main] (PlatformDependent.java:1010) org.jctools-core.MpscChunkedArrayQueue: available
14:28:46.913 [DEBUG - main] (MultithreadEventLoopGroup.java:44) -Dio.netty.eventLoopThreads: 2
14:28:46.924 [DEBUG - main] (GlobalEventExecutor.java:53) -Dio.netty.globalEventExecutor.quietPeriodSeconds: 1
14:28:46.930 [DEBUG - main] (InternalThreadLocalMap.java:100) -Dio.netty.threadLocalMap.stringBuilder.initialSize: 1024
14:28:46.930 [DEBUG - main] (InternalThreadLocalMap.java:101) -Dio.netty.threadLocalMap.stringBuilder.maxSize: 4096
14:28:46.936 [DEBUG - main] (NioEventLoop.java:110) -Dio.netty.noKeySetOptimization: false
14:28:46.936 [DEBUG - main] (NioEventLoop.java:111) -Dio.netty.selectorAutoRebuildThreshold: 512
14:28:46.966 [DEBUG - main] (PooledByteBufAllocator.java:157) -Dio.netty.allocator.numHeapArenas: 2
14:28:46.966 [DEBUG - main] (PooledByteBufAllocator.java:158) -Dio.netty.allocator.numDirectArenas: 2
14:28:46.966 [DEBUG - main] (PooledByteBufAllocator.java:160) -Dio.netty.allocator.pageSize: 8192
14:28:46.966 [DEBUG - main] (PooledByteBufAllocator.java:165) -Dio.netty.allocator.maxOrder: 9
14:28:46.966 [DEBUG - main] (PooledByteBufAllocator.java:169) -Dio.netty.allocator.chunkSize: 4194304
14:28:46.967 [DEBUG - main] (PooledByteBufAllocator.java:170) -Dio.netty.allocator.smallCacheSize: 256
14:28:46.967 [DEBUG - main] (PooledByteBufAllocator.java:171) -Dio.netty.allocator.normalCacheSize: 64
14:28:46.967 [DEBUG - main] (PooledByteBufAllocator.java:172) -Dio.netty.allocator.maxCachedBufferCapacity: 32768
14:28:46.967 [DEBUG - main] (PooledByteBufAllocator.java:173) -Dio.netty.allocator.cacheTrimInterval: 8192
14:28:46.967 [DEBUG - main] (PooledByteBufAllocator.java:174) -Dio.netty.allocator.cacheTrimIntervalMillis: 0
14:28:46.967 [DEBUG - main] (PooledByteBufAllocator.java:175) -Dio.netty.allocator.useCacheForAllThreads: false
14:28:46.967 [DEBUG - main] (PooledByteBufAllocator.java:176) -Dio.netty.allocator.maxCachedByteBuffersPerChunk: 1023
14:28:46.995 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
14:28:47.110 [INFO - main] (Logging.scala:57) Running Spark version 3.1.2
14:28:47.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.241717  1649 catalog_manager.cc:1259] Loaded cluster ID: 4cc5d952351c494f9ba3ca0ec7db90d9
14:28:47.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.241796  1649 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556: loading cluster ID for follower catalog manager: success
14:28:47.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.243095  1649 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556: acquiring CA information for follower catalog manager: success
14:28:47.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.243510  1649 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 007ec6863c8b423a9a0845c2fd58e556: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.259312  1671 catalog_manager.cc:1259] Loaded cluster ID: 4cc5d952351c494f9ba3ca0ec7db90d9
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.259384  1671 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e: loading cluster ID for follower catalog manager: success
14:28:47.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.260651  1671 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e: acquiring CA information for follower catalog manager: success
14:28:47.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.261008  1671 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 46bdbd66dd8c4df9a157328851c44e9e: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:28:47.344 [WARN - main] (NativeCodeLoader.java:60) Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
14:28:47.460 [INFO - main] (Logging.scala:57) ==============================================================
14:28:47.461 [INFO - main] (Logging.scala:57) No custom resources configured for spark.driver.
14:28:47.462 [INFO - main] (Logging.scala:57) ==============================================================
14:28:47.463 [INFO - main] (Logging.scala:57) Submitted application: test
14:28:47.492 [INFO - main] (Logging.scala:57) Default ResourceProfile created, executor resources: Map(cores -> name: cores, amount: 1, script: , vendor: , memory -> name: memory, amount: 1024, script: , vendor: , offHeap -> name: offHeap, amount: 0, script: , vendor: ), task resources: Map(cpus -> name: cpus, amount: 1.0)
14:28:47.507 [INFO - main] (Logging.scala:57) Limiting resource is cpu
14:28:47.508 [INFO - main] (Logging.scala:57) Added ResourceProfile id: 0
14:28:47.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.551424  1929 heartbeater.cc:503] Master 127.1.46.62:34223 was elected leader, sending a full tablet report...
14:28:47.624 [INFO - main] (Logging.scala:57) Changing view acls to: slave
14:28:47.624 [INFO - main] (Logging.scala:57) Changing modify acls to: slave
14:28:47.625 [INFO - main] (Logging.scala:57) Changing view acls groups to: 
14:28:47.626 [INFO - main] (Logging.scala:57) Changing modify acls groups to: 
14:28:47.626 [INFO - main] (Logging.scala:57) SecurityManager: authentication disabled; ui acls disabled; users  with view permissions: Set(slave); groups with view permissions: Set(); users  with modify permissions: Set(slave); groups with modify permissions: Set()
14:28:47.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.678610  2151 heartbeater.cc:503] Master 127.1.46.62:34223 was elected leader, sending a full tablet report...
14:28:47.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.804177  2374 heartbeater.cc:503] Master 127.1.46.62:34223 was elected leader, sending a full tablet report...
14:28:47.965 [INFO - main] (Logging.scala:57) Successfully started service 'sparkDriver' on port 40239.
14:28:47.998 [INFO - main] (Logging.scala:57) Registering MapOutputTracker
14:28:48.035 [INFO - main] (Logging.scala:57) Registering BlockManagerMaster
14:28:48.059 [INFO - main] (Logging.scala:57) Using org.apache.spark.storage.DefaultTopologyMapper for getting topology information
14:28:48.060 [INFO - main] (Logging.scala:57) BlockManagerMasterEndpoint up
14:28:48.065 [INFO - main] (Logging.scala:57) Registering BlockManagerMasterHeartbeat
14:28:48.081 [INFO - main] (Logging.scala:57) Created local directory at /tmp/blockmgr-4d1c6aa6-3d4b-4e58-a27d-ff71262e0840
14:28:48.128 [INFO - main] (Logging.scala:57) MemoryStore started with capacity 1993.9 MiB
14:28:48.146 [INFO - main] (Logging.scala:57) Registering OutputCommitCoordinator
14:28:48.325 [INFO - main] (Logging.scala:57) Starting executor ID driver on host dist-test-slave-fgb3.c.gcp-upstream.internal
14:28:48.360 [INFO - main] (Logging.scala:57) Successfully started service 'org.apache.spark.network.netty.NettyBlockTransferService' on port 33029.
14:28:48.360 [INFO - main] (NettyBlockTransferService.scala:81) Server created on dist-test-slave-fgb3.c.gcp-upstream.internal:33029
14:28:48.362 [INFO - main] (Logging.scala:57) Using org.apache.spark.storage.RandomBlockReplicationPolicy for block replication policy
14:28:48.370 [INFO - main] (Logging.scala:57) Registering BlockManager BlockManagerId(driver, dist-test-slave-fgb3.c.gcp-upstream.internal, 33029, None)
14:28:48.375 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Registering block manager dist-test-slave-fgb3.c.gcp-upstream.internal:33029 with 1993.9 MiB RAM, BlockManagerId(driver, dist-test-slave-fgb3.c.gcp-upstream.internal, 33029, None)
14:28:48.378 [INFO - main] (Logging.scala:57) Registered BlockManager BlockManagerId(driver, dist-test-slave-fgb3.c.gcp-upstream.internal, 33029, None)
14:28:48.379 [INFO - main] (Logging.scala:57) Initialized BlockManager: BlockManagerId(driver, dist-test-slave-fgb3.c.gcp-upstream.internal, 33029, None)
14:28:48.603 [INFO - main] (Log.java:169) Logging initialized @4719ms to org.sparkproject.jetty.util.log.Slf4jLog
14:28:48.817 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
14:28:48.874 [DEBUG - main] (Connection.java:748) [peer master-127.1.46.61:41403(127.1.46.61:41403)] connecting to peer
14:28:48.882 [DEBUG - main] (DefaultChannelId.java:79) -Dio.netty.processId: 1186 (auto-detected)
14:28:48.885 [DEBUG - main] (NetUtil.java:148) -Djava.net.preferIPv4Stack: true
14:28:48.886 [DEBUG - main] (NetUtil.java:149) -Djava.net.preferIPv6Addresses: false
14:28:48.888 [DEBUG - main] (NetUtilInitializations.java:145) Loopback interface: lo (lo, 127.0.0.1)
14:28:48.889 [DEBUG - main] (NetUtil.java:188) /proc/sys/net/core/somaxconn: 4096
14:28:48.891 [DEBUG - main] (DefaultChannelId.java:101) -Dio.netty.machineId: 02:42:35:ff:fe:c0:ee:9b (auto-detected)
14:28:48.923 [DEBUG - main] (ByteBufUtil.java:88) -Dio.netty.allocator.type: pooled
14:28:48.924 [DEBUG - main] (ByteBufUtil.java:97) -Dio.netty.threadLocalDirectBufferSize: 0
14:28:48.924 [DEBUG - main] (ByteBufUtil.java:100) -Dio.netty.maxThreadLocalCharBufferSize: 16384
14:28:48.936 [DEBUG - main] (Connection.java:748) [peer master-127.1.46.62:34223(127.1.46.62:34223)] connecting to peer
14:28:48.943 [DEBUG - main] (Connection.java:748) [peer master-127.1.46.60:40065(127.1.46.60:40065)] connecting to peer
14:28:48.969 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.1.46.62:34223(127.1.46.62:34223)] Successfully connected to peer
14:28:48.969 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.1.46.61:41403(127.1.46.61:41403)] Successfully connected to peer
14:28:48.981 [DEBUG - kudu-nio-0] (AbstractByteBuf.java:63) -Dorg.apache.kudu.shaded.io.netty.buffer.checkAccessible: true
14:28:48.981 [DEBUG - kudu-nio-0] (AbstractByteBuf.java:64) -Dorg.apache.kudu.shaded.io.netty.buffer.checkBounds: true
14:28:48.982 [DEBUG - kudu-nio-0] (ResourceLeakDetectorFactory.java:196) Loaded default ResourceLeakDetector: org.apache.kudu.shaded.io.netty.util.ResourceLeakDetector@56172f07
14:28:48.987 [DEBUG - kudu-nio-0] (Recycler.java:96) -Dio.netty.recycler.maxCapacityPerThread: 4096
14:28:48.987 [DEBUG - kudu-nio-0] (Recycler.java:97) -Dio.netty.recycler.ratio: 8
14:28:48.987 [DEBUG - kudu-nio-0] (Recycler.java:98) -Dio.netty.recycler.chunkSize: 32
14:28:48.987 [DEBUG - kudu-nio-0] (Recycler.java:99) -Dio.netty.recycler.blocking: false
14:28:48.987 [DEBUG - kudu-nio-0] (Recycler.java:100) -Dio.netty.recycler.batchFastThreadLocalOnly: true
14:28:49.030 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.1.46.60:40065(127.1.46.60:40065)] Successfully connected to peer
14:28:49.052 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.1.46.61
14:28:49.052 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.1.46.62
14:28:49.150 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.1.46.60
14:28:49.237 [DEBUG - kudu-nio-1] (SslHandler.java:1842) [id: 0xembedded, L:embedded - R:embedded] HANDSHAKEN: protocol:TLSv1.2 cipher suite:TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256
14:28:49.252 [DEBUG - kudu-nio-0] (SslHandler.java:1842) [id: 0xembedded, L:embedded - R:embedded] HANDSHAKEN: protocol:TLSv1.2 cipher suite:TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256
14:28:49.256 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x4bfe70ba, L:/127.0.0.1:45070 - R:/127.1.46.61:41403] using SASL/PLAIN
14:28:49.253 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xb4a5f400, L:/127.0.0.1:54346 - R:/127.1.46.62:34223] using SASL/PLAIN
14:28:49.265 [DEBUG - kudu-nio-0] (SslHandler.java:1842) [id: 0xembedded, L:embedded - R:embedded] HANDSHAKEN: protocol:TLSv1.2 cipher suite:TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256
14:28:49.279 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x3cf24349, L:/127.0.0.1:38740 - R:/127.1.46.60:40065] using SASL/PLAIN
14:28:49.304 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:28:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.379438  1287 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:54346:
14:28:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "test"
14:28:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
14:28:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
14:28:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:28:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
14:28:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c1_i"
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c2_s"
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c3_double"
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DOUBLE
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c4_long"
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT64
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c5_bool"
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c6_short"
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT16
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c7_float"
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: FLOAT
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c8_binary"
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BINARY
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c9_unixtime_micros"
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: UNIXTIME_MICROS
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c10_byte"
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT8
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c11_decimal32"
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL32
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 9
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:28:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c12_decimal64"
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL64
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 18
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c13_decimal128"
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DECIMAL128
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       precision: 38
14:28:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c14_varchar"
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: VARCHAR
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type_attributes {
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       length: 65535
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "c15_date"
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: DATE
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) split_rows_range_bounds {
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   rows: "<redacted>""\006\000\000\000\000\007\001\000\000\0002\000\000\000\006\001\000\000\0002\000\000\000\007\000\000\000\000"
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
14:28:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:28:49.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:28:49.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) owner: "testuser"
14:28:49.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.392117  2258 tablet_service.cc:1467] Processing CreateTablet for tablet 8873d955720a43459b144c0f75a6fe2c (DEFAULT_TABLE table=test [id=4307c53ec99d4701af1df58d2145fe5a]), partition=RANGE (key) PARTITION VALUES < 50
14:28:49.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.392577  2258 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 8873d955720a43459b144c0f75a6fe2c. 1 dirs total, 0 dirs full, 0 dirs failed
14:28:49.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.392995  1827 tablet_service.cc:1467] Processing CreateTablet for tablet 7f5f43662b594d049515412214722685 (DEFAULT_TABLE table=test [id=4307c53ec99d4701af1df58d2145fe5a]), partition=RANGE (key) PARTITION 50 <= VALUES
14:28:49.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.393384  1827 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 7f5f43662b594d049515412214722685. 1 dirs total, 0 dirs full, 0 dirs failed
14:28:49.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.395999  2477 tablet_bootstrap.cc:492] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b: Bootstrap starting.
14:28:49.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.396824  2477 tablet_bootstrap.cc:654] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b: Neither blocks nor log segments found. Creating new log.
14:28:49.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.396924  2482 tablet_bootstrap.cc:492] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7: Bootstrap starting.
14:28:49.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.397558  2482 tablet_bootstrap.cc:654] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7: Neither blocks nor log segments found. Creating new log.
14:28:49.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.397573  2477 log.cc:824] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b: Log is configured to *not* fsync() on all Append() calls
14:28:49.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.398130  2482 log.cc:824] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7: Log is configured to *not* fsync() on all Append() calls
14:28:49.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.398209  2477 tablet_bootstrap.cc:492] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b: No bootstrap required, opened a new log
14:28:49.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.398267  2477 ts_tablet_manager.cc:1397] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b: Time spent bootstrapping tablet: real 0.002s	user 0.001s	sys 0.000s
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.399012  2482 tablet_bootstrap.cc:492] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7: No bootstrap required, opened a new log
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.399075  2482 ts_tablet_manager.cc:1397] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7: Time spent bootstrapping tablet: real 0.002s	user 0.002s	sys 0.000s
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.400750  2477 raft_consensus.cc:348] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "bda51bf553914065af471adc3ff40f1b" member_type: VOTER last_known_addr { host: "127.1.46.3" port: 42121 } }
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.400894  2477 raft_consensus.cc:374] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.400923  2477 raft_consensus.cc:729] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: bda51bf553914065af471adc3ff40f1b, State: Initialized, Role: FOLLOWER
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401046  2477 consensus_queue.cc:260] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [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: "bda51bf553914065af471adc3ff40f1b" member_type: VOTER last_known_addr { host: "127.1.46.3" port: 42121 } }
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401116  2477 raft_consensus.cc:388] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401142  2477 raft_consensus.cc:482] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401177  2477 raft_consensus.cc:3037] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [term 0 FOLLOWER]: Advancing to term 1
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401430  2482 raft_consensus.cc:348] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c78c5b7e3482475b8c8af7f63690b6f7" member_type: VOTER last_known_addr { host: "127.1.46.1" port: 35355 } }
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401573  2482 raft_consensus.cc:374] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401603  2482 raft_consensus.cc:729] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c78c5b7e3482475b8c8af7f63690b6f7, State: Initialized, Role: FOLLOWER
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401702  2482 consensus_queue.cc:260] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [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: "c78c5b7e3482475b8c8af7f63690b6f7" member_type: VOTER last_known_addr { host: "127.1.46.1" port: 35355 } }
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401782  2482 raft_consensus.cc:388] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401813  2482 raft_consensus.cc:482] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401808  2477 raft_consensus.cc:504] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "bda51bf553914065af471adc3ff40f1b" member_type: VOTER last_known_addr { host: "127.1.46.3" port: 42121 } }
14:28:49.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401857  2482 raft_consensus.cc:3037] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [term 0 FOLLOWER]: Advancing to term 1
14:28:49.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.401907  2477 leader_election.cc:302] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [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: bda51bf553914065af471adc3ff40f1b; no voters: 
14:28:49.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.402030  2477 leader_election.cc:288] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [CANDIDATE]: Term 1 election: Requested vote from peers 
14:28:49.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.402211  2477 ts_tablet_manager.cc:1428] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b: Time spent starting tablet: real 0.004s	user 0.000s	sys 0.004s
14:28:49.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.403802  2482 raft_consensus.cc:504] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c78c5b7e3482475b8c8af7f63690b6f7" member_type: VOTER last_known_addr { host: "127.1.46.1" port: 35355 } }
14:28:49.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.403908  2482 leader_election.cc:302] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [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: c78c5b7e3482475b8c8af7f63690b6f7; no voters: 
14:28:49.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.404036  2482 leader_election.cc:288] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [CANDIDATE]: Term 1 election: Requested vote from peers 
14:28:49.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.404207  2482 ts_tablet_manager.cc:1428] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7: Time spent starting tablet: real 0.005s	user 0.004s	sys 0.000s
14:28:49.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.404207  2486 raft_consensus.cc:2781] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [term 1 FOLLOWER]: Leader election won for term 1
14:28:49.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.404367  2486 raft_consensus.cc:686] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [term 1 LEADER]: Becoming Leader. State: Replica: bda51bf553914065af471adc3ff40f1b, State: Running, Role: LEADER
14:28:49.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.404450  2486 consensus_queue.cc:237] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b [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: "bda51bf553914065af471adc3ff40f1b" member_type: VOTER last_known_addr { host: "127.1.46.3" port: 42121 } }
14:28:49.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.406540  1287 catalog_manager.cc:5495] T 8873d955720a43459b144c0f75a6fe2c P bda51bf553914065af471adc3ff40f1b reported cstate change: term changed from 0 to 1, leader changed from <none> to bda51bf553914065af471adc3ff40f1b (127.1.46.3). New cstate: current_term: 1 leader_uuid: "bda51bf553914065af471adc3ff40f1b" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "bda51bf553914065af471adc3ff40f1b" member_type: VOTER last_known_addr { host: "127.1.46.3" port: 42121 } health_report { overall_health: HEALTHY } } }
14:28:49.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.409216  2489 raft_consensus.cc:2781] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [term 1 FOLLOWER]: Leader election won for term 1
14:28:49.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.409380  2489 raft_consensus.cc:686] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [term 1 LEADER]: Becoming Leader. State: Replica: c78c5b7e3482475b8c8af7f63690b6f7, State: Running, Role: LEADER
14:28:49.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.409479  2489 consensus_queue.cc:237] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 [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: "c78c5b7e3482475b8c8af7f63690b6f7" member_type: VOTER last_known_addr { host: "127.1.46.1" port: 35355 } }
14:28:49.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.410076  1287 catalog_manager.cc:5495] T 7f5f43662b594d049515412214722685 P c78c5b7e3482475b8c8af7f63690b6f7 reported cstate change: term changed from 0 to 1, leader changed from <none> to c78c5b7e3482475b8c8af7f63690b6f7 (127.1.46.1). New cstate: current_term: 1 leader_uuid: "c78c5b7e3482475b8c8af7f63690b6f7" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c78c5b7e3482475b8c8af7f63690b6f7" member_type: VOTER last_known_addr { host: "127.1.46.1" port: 35355 } health_report { overall_health: HEALTHY } } }
14:28:49.419 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 4307c53ec99d4701af1df58d2145fe5a
14:28:49.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.441615  1287 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:54346:
14:28:49.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "simple-test"
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "val"
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:49.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:28:49.448 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table d318f3d8f5864a34b5758c209a9bece5
14:28:49.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.449554  2034 tablet_service.cc:1467] Processing CreateTablet for tablet 012d8ba238cf4bd18202e10dfadf0f18 (DEFAULT_TABLE table=simple-test [id=d318f3d8f5864a34b5758c209a9bece5]), partition=RANGE (key) PARTITION UNBOUNDED
14:28:49.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.449889  2034 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 012d8ba238cf4bd18202e10dfadf0f18. 1 dirs total, 0 dirs full, 0 dirs failed
14:28:49.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.452888  2502 tablet_bootstrap.cc:492] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9: Bootstrap starting.
14:28:49.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.453504  2502 tablet_bootstrap.cc:654] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9: Neither blocks nor log segments found. Creating new log.
14:28:49.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.453747  2502 log.cc:824] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9: Log is configured to *not* fsync() on all Append() calls
14:28:49.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.454273  2502 tablet_bootstrap.cc:492] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9: No bootstrap required, opened a new log
14:28:49.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.454349  2502 ts_tablet_manager.cc:1397] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9: Time spent bootstrapping tablet: real 0.002s	user 0.001s	sys 0.000s
14:28:49.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.456207  2502 raft_consensus.cc:348] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "eb07dc6907ff4221944484768a1d88a9" member_type: VOTER last_known_addr { host: "127.1.46.2" port: 43995 } }
14:28:49.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.456332  2502 raft_consensus.cc:374] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:28:49.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.456352  2502 raft_consensus.cc:729] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: eb07dc6907ff4221944484768a1d88a9, State: Initialized, Role: FOLLOWER
14:28:49.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.456434  2502 consensus_queue.cc:260] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [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: "eb07dc6907ff4221944484768a1d88a9" member_type: VOTER last_known_addr { host: "127.1.46.2" port: 43995 } }
14:28:49.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.456494  2502 raft_consensus.cc:388] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
14:28:49.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.456514  2502 raft_consensus.cc:482] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
14:28:49.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.456540  2502 raft_consensus.cc:3037] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [term 0 FOLLOWER]: Advancing to term 1
14:28:49.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.456981  2502 raft_consensus.cc:504] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "eb07dc6907ff4221944484768a1d88a9" member_type: VOTER last_known_addr { host: "127.1.46.2" port: 43995 } }
14:28:49.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.457063  2502 leader_election.cc:302] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [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: eb07dc6907ff4221944484768a1d88a9; no voters: 
14:28:49.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.457168  2502 leader_election.cc:288] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [CANDIDATE]: Term 1 election: Requested vote from peers 
14:28:49.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.457198  2504 raft_consensus.cc:2781] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [term 1 FOLLOWER]: Leader election won for term 1
14:28:49.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.457360  2504 raft_consensus.cc:686] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [term 1 LEADER]: Becoming Leader. State: Replica: eb07dc6907ff4221944484768a1d88a9, State: Running, Role: LEADER
14:28:49.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.457368  2502 ts_tablet_manager.cc:1428] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9: Time spent starting tablet: real 0.003s	user 0.003s	sys 0.000s
14:28:49.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.457587  2504 consensus_queue.cc:237] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 [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: "eb07dc6907ff4221944484768a1d88a9" member_type: VOTER last_known_addr { host: "127.1.46.2" port: 43995 } }
14:28:49.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.458343  1287 catalog_manager.cc:5495] T 012d8ba238cf4bd18202e10dfadf0f18 P eb07dc6907ff4221944484768a1d88a9 reported cstate change: term changed from 0 to 1, leader changed from <none> to eb07dc6907ff4221944484768a1d88a9 (127.1.46.2). New cstate: current_term: 1 leader_uuid: "eb07dc6907ff4221944484768a1d88a9" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "eb07dc6907ff4221944484768a1d88a9" member_type: VOTER last_known_addr { host: "127.1.46.2" port: 43995 } health_report { overall_health: HEALTHY } } }
14:28:51.003 [INFO - main] (Logging.scala:57) Setting hive.metastore.warehouse.dir ('null') to the value of spark.sql.warehouse.dir ('file:/tmp/dist-test-taskdU6HUy/java/build/dist-test/spark-warehouse').
14:28:51.003 [INFO - main] (Logging.scala:57) Warehouse path is 'file:/tmp/dist-test-taskdU6HUy/java/build/dist-test/spark-warehouse'.
14:28:52.389 [INFO - main] (Logging.scala:57) Registered StateStoreCoordinator endpoint
log4j:WARN No appenders could be found for logger (org.apache.htrace.core.Tracer).
log4j:WARN Please initialize the log4j system properly.
log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
14:28:52.546 [INFO - main] (Logging.scala:57) Checkpoint root /tmp/spark_kudu1447088611007883692 resolved to file:/tmp/spark_kudu1447088611007883692.
14:28:52.626 [INFO - main] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu1447088611007883692/metadata using temp file file:/tmp/spark_kudu1447088611007883692/.metadata.3c92b2da-e1d8-4d42-bb4f-8c118438dd09.tmp
14:28:52.772 [INFO - main] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu1447088611007883692/.metadata.3c92b2da-e1d8-4d42-bb4f-8c118438dd09.tmp to file:/tmp/spark_kudu1447088611007883692/metadata
14:28:52.816 [INFO - main] (Logging.scala:57) Starting [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]. Use file:/tmp/spark_kudu1447088611007883692 to store the query checkpoint.
14:28:52.834 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Reading table [org.apache.spark.sql.execution.streaming.MemoryStreamTable@14f918c3] from DataSourceV2 named 'memory' [org.apache.spark.sql.execution.streaming.MemoryStreamTableProvider$@19e9285b]
14:28:52.851 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Starting new streaming query.
14:28:52.855 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Stream started from {}
14:28:52.953 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Streaming query made progress: {
  "id" : "a336f443-a6a1-42d2-a1c4-554340d3390d",
  "runId" : "429a4035-968a-451f-8995-85fc696f405b",
  "name" : null,
  "timestamp" : "2026-08-11T14:28:52.847Z",
  "batchId" : 0,
  "numInputRows" : 0,
  "inputRowsPerSecond" : 0.0,
  "processedRowsPerSecond" : 0.0,
  "durationMs" : {
    "latestOffset" : 0,
    "triggerExecution" : 17
  },
  "stateOperators" : [ ],
  "sources" : [ {
    "description" : "MemoryStream[value#1]",
    "startOffset" : null,
    "endOffset" : null,
    "numInputRows" : 0,
    "inputRowsPerSecond" : 0.0,
    "processedRowsPerSecond" : 0.0
  } ],
  "sink" : {
    "description" : "org.apache.kudu.spark.kudu.KuduSink@22035274",
    "numOutputRows" : -1
  }
}
14:28:53.188 [INFO - main] (Logging.scala:57) Code generated in 222.733628 ms
14:28:53.212 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu1447088611007883692/offsets/0 using temp file file:/tmp/spark_kudu1447088611007883692/offsets/.0.52ce247c-d9d0-400b-89b4-c906180a437e.tmp
14:28:53.249 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu1447088611007883692/offsets/.0.52ce247c-d9d0-400b-89b4-c906180a437e.tmp to file:/tmp/spark_kudu1447088611007883692/offsets/0
14:28:53.250 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Committed offsets for batch 0. Metadata OffsetSeqMetadata(0,1786458533192,Map(spark.sql.streaming.stateStore.providerClass -> org.apache.spark.sql.execution.streaming.state.HDFSBackedStateStoreProvider, spark.sql.streaming.join.stateFormatVersion -> 2, spark.sql.streaming.stateStore.compression.codec -> lz4, spark.sql.streaming.flatMapGroupsWithState.stateFormatVersion -> 2, spark.sql.streaming.multipleWatermarkPolicy -> min, spark.sql.streaming.aggregation.stateFormatVersion -> 2, spark.sql.shuffle.partitions -> 200))
14:28:54.214 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Code generated in 47.644439 ms
14:28:54.407 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Starting job: start at StreamingTest.scala:54
14:28:54.430 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Got job 0 (start at StreamingTest.scala:54) with 1 output partitions
14:28:54.430 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Final stage: ResultStage 0 (start at StreamingTest.scala:54)
14:28:54.431 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Parents of final stage: List()
14:28:54.433 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Missing parents: List()
14:28:54.440 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting ResultStage 0 (MapPartitionsRDD[4] at start at StreamingTest.scala:54), which has no missing parents
14:28:54.535 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Block broadcast_0 stored as values in memory (estimated size 17.1 KiB, free 1993.9 MiB)
14:28:54.575 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Block broadcast_0_piece0 stored as bytes in memory (estimated size 7.8 KiB, free 1993.9 MiB)
14:28:54.579 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Added broadcast_0_piece0 in memory on dist-test-slave-fgb3.c.gcp-upstream.internal:33029 (size: 7.8 KiB, free: 1993.9 MiB)
14:28:54.581 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Created broadcast 0 from broadcast at DAGScheduler.scala:1388
14:28:54.596 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting 1 missing tasks from ResultStage 0 (MapPartitionsRDD[4] at start at StreamingTest.scala:54) (first 15 tasks are for partitions Vector(0))
14:28:54.597 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Adding task set 0.0 with 1 tasks resource profile 0
14:28:54.668 [INFO - dispatcher-event-loop-1] (Logging.scala:57) Starting task 0.0 in stage 0.0 (TID 0) (dist-test-slave-fgb3.c.gcp-upstream.internal, executor driver, partition 0, PROCESS_LOCAL, 4803 bytes) taskResourceAssignments Map()
14:28:54.690 [INFO - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (Logging.scala:57) Running task 0.0 in stage 0.0 (TID 0)
14:28:55.096 [DEBUG - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (SecurityContext.java:320) Importing authentication credentials with one authn token, with no JWT, 1 cert(s), and realUser=slave
14:28:55.100 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table d318f3d8f5864a34b5758c209a9bece5
14:28:55.105 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table d318f3d8f5864a34b5758c209a9bece5
14:28:55.111 [INFO - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (KuduContext.scala:515) applying operations of type 'upsert' to table 'simple-test'
14:28:55.126 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 012d8ba238cf4bd18202e10dfadf0f18 for table 'simple-test' with partition [<start>, <end>)
14:28:55.129 [DEBUG - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=3, operationSize=114, flusherTask=org.apache.kudu.client.AsyncKuduSession$FlusherTask@5b032a6, flushNotification=Deferred@1035309095(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:28:55.126 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299987, tablet=012d8ba238cf4bd18202e10dfadf0f18@[eb07dc6907ff4221944484768a1d88a9(127.1.46.2:43995)[L]]}]
14:28:55.144 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 012d8ba238cf4bd18202e10dfadf0f18 for table 'simple-test' with partition [<start>, <end>)
14:28:55.144 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=012d8ba238cf4bd18202e10dfadf0f18@[eb07dc6907ff4221944484768a1d88a9(127.1.46.2:43995)[L]]}]
14:28:55.146 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 012d8ba238cf4bd18202e10dfadf0f18 for table 'simple-test' with partition [<start>, <end>)
14:28:55.147 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=012d8ba238cf4bd18202e10dfadf0f18@[eb07dc6907ff4221944484768a1d88a9(127.1.46.2:43995)[L]]}]
14:28:55.160 [DEBUG - kudu-nio-1] (Connection.java:748) [peer eb07dc6907ff4221944484768a1d88a9(127.1.46.2:43995)] connecting to peer
14:28:55.163 [DEBUG - kudu-nio-1] (Connection.java:757) [peer eb07dc6907ff4221944484768a1d88a9(127.1.46.2:43995)] Successfully connected to peer
14:28:55.200 [DEBUG - kudu-nio-1] (SslHandler.java:1842) [id: 0xembedded, L:embedded - R:embedded] HANDSHAKEN: protocol:TLSv1.2 cipher suite:TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256
14:28:55.203 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xb01f4072, L:/127.0.0.1:53848 - R:/127.1.46.2:43995] using TOKEN/null
14:28:55.237 [INFO - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (KuduContext.scala:536) applied 3 upserts to table 'simple-test' in 121ms
14:28:55.261 [INFO - Executor task launch worker for task 0.0 in stage 0.0 (TID 0)] (Logging.scala:57) Finished task 0.0 in stage 0.0 (TID 0). 6750 bytes result sent to driver
14:28:55.273 [INFO - task-result-getter-0] (Logging.scala:57) Finished task 0.0 in stage 0.0 (TID 0) in 621 ms on dist-test-slave-fgb3.c.gcp-upstream.internal (executor driver) (1/1)
14:28:55.276 [INFO - task-result-getter-0] (Logging.scala:57) Removed TaskSet 0.0, whose tasks have all completed, from pool 
14:28:55.300 [INFO - dag-scheduler-event-loop] (Logging.scala:57) ResultStage 0 (start at StreamingTest.scala:54) finished in 0.843 s
14:28:55.306 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Job 0 is finished. Cancelling potential speculative or zombie tasks for this job
14:28:55.307 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Killing all running tasks in stage 0: Stage finished
14:28:55.309 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Job 0 finished: start at StreamingTest.scala:54, took 0.902195 s
14:28:55.316 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (KuduContext.scala:445) completed upsert ops: duration histogram: 121ms
14:28:55.346 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Writing atomically to file:/tmp/spark_kudu1447088611007883692/commits/0 using temp file file:/tmp/spark_kudu1447088611007883692/commits/.0.9744281b-fd20-497d-a47b-0b8c9e5c241a.tmp
14:28:55.367 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Renamed temp file file:/tmp/spark_kudu1447088611007883692/commits/.0.9744281b-fd20-497d-a47b-0b8c9e5c241a.tmp to file:/tmp/spark_kudu1447088611007883692/commits/0
14:28:55.381 [INFO - stream execution thread for [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b]] (Logging.scala:57) Streaming query made progress: {
  "id" : "a336f443-a6a1-42d2-a1c4-554340d3390d",
  "runId" : "429a4035-968a-451f-8995-85fc696f405b",
  "name" : null,
  "timestamp" : "2026-08-11T14:28:53.192Z",
  "batchId" : 0,
  "numInputRows" : 3,
  "inputRowsPerSecond" : 272.72727272727275,
  "processedRowsPerSecond" : 1.3786764705882353,
  "durationMs" : {
    "addBatch" : 1530,
    "getBatch" : 3,
    "latestOffset" : 0,
    "queryPlanning" : 530,
    "triggerExecution" : 2176,
    "walCommit" : 57
  },
  "stateOperators" : [ ],
  "sources" : [ {
    "description" : "MemoryStream[value#1]",
    "startOffset" : null,
    "endOffset" : 0,
    "numInputRows" : 3,
    "inputRowsPerSecond" : 272.72727272727275,
    "processedRowsPerSecond" : 1.3786764705882353
  } ],
  "sink" : {
    "description" : "org.apache.kudu.spark.kudu.KuduSink@22035274",
    "numOutputRows" : -1
  }
}
14:28:55.395 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table d318f3d8f5864a34b5758c209a9bece5
14:28:55.491 [INFO - main] (Logging.scala:57) Code generated in 11.666687 ms
14:28:55.590 [INFO - main] (Logging.scala:57) Starting job: collect at StreamingTest.scala:60
14:28:55.592 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Got job 1 (collect at StreamingTest.scala:60) with 1 output partitions
14:28:55.592 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Final stage: ResultStage 1 (collect at StreamingTest.scala:60)
14:28:55.592 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Parents of final stage: List()
14:28:55.593 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Missing parents: List()
14:28:55.594 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting ResultStage 1 (MapPartitionsRDD[11] at map at StreamingTest.scala:60), which has no missing parents
14:28:55.604 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Block broadcast_1 stored as values in memory (estimated size 18.6 KiB, free 1993.8 MiB)
14:28:55.607 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Block broadcast_1_piece0 stored as bytes in memory (estimated size 9.1 KiB, free 1993.8 MiB)
14:28:55.608 [INFO - dispatcher-BlockManagerMaster] (Logging.scala:57) Added broadcast_1_piece0 in memory on dist-test-slave-fgb3.c.gcp-upstream.internal:33029 (size: 9.1 KiB, free: 1993.9 MiB)
14:28:55.608 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Created broadcast 1 from broadcast at DAGScheduler.scala:1388
14:28:55.609 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Submitting 1 missing tasks from ResultStage 1 (MapPartitionsRDD[11] at map at StreamingTest.scala:60) (first 15 tasks are for partitions Vector(0))
14:28:55.609 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Adding task set 1.0 with 1 tasks resource profile 0
14:28:55.616 [INFO - dispatcher-event-loop-0] (Logging.scala:57) Starting task 0.0 in stage 1.0 (TID 1) (dist-test-slave-fgb3.c.gcp-upstream.internal, executor driver, partition 0, ANY, 4792 bytes) taskResourceAssignments Map()
14:28:55.616 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Running task 0.0 in stage 1.0 (TID 1)
14:28:55.697 [DEBUG - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (SecurityContext.java:320) Importing authentication credentials with one authn token, with no JWT, 1 cert(s), and realUser=slave
14:28:55.739 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Code generated in 14.686268 ms
14:28:55.773 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7317334162484207616) for scanner KuduScanner(table=simple-test, tablet=012d8ba238cf4bd18202e10dfadf0f18, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:28:55.820 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Code generated in 32.456823 ms
14:28:55.842 [INFO - Executor task launch worker for task 0.0 in stage 1.0 (TID 1)] (Logging.scala:57) Finished task 0.0 in stage 1.0 (TID 1). 5410 bytes result sent to driver
14:28:55.847 [INFO - task-result-getter-1] (Logging.scala:57) Finished task 0.0 in stage 1.0 (TID 1) in 233 ms on dist-test-slave-fgb3.c.gcp-upstream.internal (executor driver) (1/1)
14:28:55.848 [INFO - task-result-getter-1] (Logging.scala:57) Removed TaskSet 1.0, whose tasks have all completed, from pool 
14:28:55.849 [INFO - dag-scheduler-event-loop] (Logging.scala:57) ResultStage 1 (collect at StreamingTest.scala:60) finished in 0.249 s
14:28:55.849 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Job 1 is finished. Cancelling potential speculative or zombie tasks for this job
14:28:55.849 [INFO - dag-scheduler-event-loop] (Logging.scala:57) Killing all running tasks in stage 1: Stage finished
14:28:55.850 [INFO - main] (Logging.scala:57) Job 1 finished: collect at StreamingTest.scala:60, took 0.258920 s
14:28:55.853 [INFO - main] (Logging.scala:57) Asked to cancel job group 429a4035-968a-451f-8995-85fc696f405b
14:28:55.867 [INFO - main] (Logging.scala:57) Asked to cancel job group 429a4035-968a-451f-8995-85fc696f405b
14:28:55.868 [INFO - main] (Logging.scala:57) Query [id = a336f443-a6a1-42d2-a1c4-554340d3390d, runId = 429a4035-968a-451f-8995-85fc696f405b] was stopped
14:28:55.885 [INFO - dispatcher-event-loop-0] (Logging.scala:57) MapOutputTrackerMasterEndpoint stopped!
14:28:55.897 [INFO - main] (Logging.scala:57) MemoryStore cleared
14:28:55.897 [INFO - main] (Logging.scala:57) BlockManager stopped
14:28:55.905 [INFO - main] (Logging.scala:57) BlockManagerMaster stopped
14:28:55.909 [INFO - dispatcher-event-loop-0] (Logging.scala:57) OutputCommitCoordinator stopped!
14:28:55.914 [INFO - main] (Logging.scala:57) Successfully stopped SparkContext
14:28:55.917 [DEBUG - main] (Connection.java:575) [peer master-127.1.46.61:41403(127.1.46.61:41403)] disconnecting while in state READY
14:28:55.918 [DEBUG - main] (Connection.java:575) [peer master-127.1.46.62:34223(127.1.46.62:34223)] disconnecting while in state READY
14:28:55.919 [DEBUG - main] (Connection.java:575) [peer master-127.1.46.60:40065(127.1.46.60:40065)] disconnecting while in state READY
14:28:55.920 [DEBUG - main] (Connection.java:575) [peer eb07dc6907ff4221944484768a1d88a9(127.1.46.2:43995)] disconnecting while in state READY
14:28:55.929 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.1.46.61:41403(127.1.46.61:41403)] handling channelInactive
14:28:55.930 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:28:55.931 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.1.46.62:34223(127.1.46.62:34223)] handling channelInactive
14:28:55.931 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.1.46.61:41403(127.1.46.61:41403)] cleaning up while in state READY due to: connection closed
14:28:55.931 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.1.46.60:40065(127.1.46.60:40065)] handling channelInactive
14:28:55.932 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.1.46.60:40065(127.1.46.60:40065)] cleaning up while in state READY due to: connection closed
14:28:55.933 [DEBUG - kudu-nio-0] (PoolThreadCache.java:221) Freed 20 thread-local buffer(s) from thread: kudu-nio-0
14:28:55.933 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.1.46.62:34223(127.1.46.62:34223)] cleaning up while in state READY due to: connection closed
14:28:55.934 [DEBUG - kudu-nio-1] (Connection.java:239) [peer eb07dc6907ff4221944484768a1d88a9(127.1.46.2:43995)] handling channelInactive
14:28:55.934 [DEBUG - kudu-nio-1] (Connection.java:709) [peer eb07dc6907ff4221944484768a1d88a9(127.1.46.2:43995)] cleaning up while in state READY due to: connection closed
14:28:55.934 [DEBUG - kudu-nio-1] (PoolThreadCache.java:221) Freed 31 thread-local buffer(s) from thread: kudu-nio-1
14:28:55.942 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:28:55.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:55.946691  1208 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskdU6HUy/build/release/bin/kudu with pid 1716
14:28:55.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:55.970608  1208 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskdU6HUy/build/release/bin/kudu with pid 1938
14:28:55.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:55.989317  1208 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskdU6HUy/build/release/bin/kudu with pid 2165
14:28:55.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:55.999661  1208 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskdU6HUy/build/release/bin/kudu with pid 1225
14:28:56.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:56.010221  1208 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskdU6HUy/build/release/bin/kudu with pid 1353
14:28:56.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:56.022253  1208 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskdU6HUy/build/release/bin/kudu with pid 1493
14:28:56.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T14:28:56Z chronyd exiting

Time: 12.062

OK (1 test)

14:28:56.317 [INFO - shutdown-hook-0] (Logging.scala:57) Shutdown hook called
14:28:56.318 [INFO - shutdown-hook-0] (Logging.scala:57) Deleting directory /tmp/spark-3f766456-8a09-463b-9f79-ebfea9be5fba
