[2024/05/19 13:05:17.929 +08:00] [INFO] [lib.rs:90] ["Welcome to TiKV"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [INFO] [lib.rs:95] ["Release Version:   8.2.0-alpha"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [INFO] [lib.rs:95] ["Edition:           Community"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [INFO] [lib.rs:95] ["Git Commit Hash:   a1a8672e93c4da9c2dc5704151314d92e1bc4c04"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [INFO] [lib.rs:95] ["Git Commit Branch: master"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [INFO] [lib.rs:95] ["UTC Build Time:    2024-05-17 07:51:19"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [INFO] [lib.rs:95] ["Rust Version:      rustc 1.77.0-nightly (89e2160c4 2023-12-27)"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [INFO] [lib.rs:95] ["Enable Features:   memory-engine pprof-fp jemalloc mem-profiling portable sse test-engine-kv-rocksdb test-engine-raft-raft-engine trace-async-tasks openssl-vendored"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [INFO] [lib.rs:95] ["Profile:           dist_release"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [INFO] [fips.rs:40] ["OpenSSL FIPS mode is disabled"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [ERROR] [mod.rs:3319] ["failed to enable heap profiling"] [err="JemallocError(\"failed to activate profiling: `name` or `mib` specifies an unknown/invalid value.\")"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [INFO] [mod.rs:118] ["cgroup quota: memory=Some(34359738368), cpu=Some(8.0), cores={23, 8, 52, 48, 24, 0, 29, 68, 60, 55, 64, 12, 53, 57, 59, 70, 17, 19, 25, 42, 15, 30, 58, 36, 67, 71, 46, 13, 62, 26, 9, 32, 33, 47, 66, 69, 31, 14, 27, 22, 11, 21, 7, 43, 16, 61, 50, 34, 44, 65, 28, 56, 10, 49, 63, 51, 35, 54, 45, 18, 20}"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [INFO] [mod.rs:125] ["memory limit in bytes: 34359738368, cpu cores quota: 8"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [WARN] [server.rs:1755] ["check: kernel"] [err="kernel parameters net.core.somaxconn got 128, expect 32768"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [WARN] [server.rs:1755] ["check: kernel"] [err="kernel parameters net.ipv4.tcp_syncookies got 1, expect 0"] [thread_id=1]
[2024/05/19 13:05:17.929 +08:00] [WARN] [server.rs:1755] ["check: kernel"] [err="kernel parameters vm.swappiness got 10, expect 0"] [thread_id=1]
[2024/05/19 13:05:17.931 +08:00] [INFO] [util.rs:639] ["connecting to PD endpoint"] [endpoints=127.0.0.1:2399] [thread_id=1]
[2024/05/19 13:05:17.931 +08:00] [INFO] [<unknown>] ["TCP_USER_TIMEOUT is available. TCP_USER_TIMEOUT will be used thereafter"] [thread_id=1]
[2024/05/19 13:05:17.931 +08:00] [INFO] [<unknown>] ["subchannel 0x7f175b84d800 {address=ipv4:127.0.0.1:2399, args=grpc.client_channel_factory=0x7f175b8afb88, grpc.default_authority=127.0.0.1:2399, grpc.initial_reconnect_backoff_ms=1000, grpc.internal.subchannel_pool=0x7f175b837ea0, grpc.keepalive_time_ms=10000, grpc.keepalive_timeout_ms=3000, grpc.max_receive_message_length=-1, grpc.max_reconnect_backoff_ms=5000, grpc.max_send_message_length=-1, grpc.primary_user_agent=grpc-rust/0.10.4, grpc.resource_quota=0x7f175b8d2f30, grpc.server_uri=dns:///127.0.0.1:2399}: connect failed: {\"created\":\"@1716095117.931588426\",\"description\":\"Failed to connect to remote host: Connection refused\",\"errno\":111,\"file\":\"/var/cache/cargohome/registry/src/index.crates.io-6f17d22bba15001f/grpcio-sys-0.10.3+1.44.0-patched/grpc/src/core/lib/iomgr/tcp_client_posix.cc\",\"file_line\":200,\"os_error\":\"Connection refused\",\"syscall\":\"connect\",\"target_address\":\"ipv4:127.0.0.1:2399\"}"] [thread_id=13]
[2024/05/19 13:05:17.931 +08:00] [INFO] [<unknown>] ["subchannel 0x7f175b84d800 {address=ipv4:127.0.0.1:2399, args=grpc.client_channel_factory=0x7f175b8afb88, grpc.default_authority=127.0.0.1:2399, grpc.initial_reconnect_backoff_ms=1000, grpc.internal.subchannel_pool=0x7f175b837ea0, grpc.keepalive_time_ms=10000, grpc.keepalive_timeout_ms=3000, grpc.max_receive_message_length=-1, grpc.max_reconnect_backoff_ms=5000, grpc.max_send_message_length=-1, grpc.primary_user_agent=grpc-rust/0.10.4, grpc.resource_quota=0x7f175b8d2f30, grpc.server_uri=dns:///127.0.0.1:2399}: Retry in 999 milliseconds"] [thread_id=13]
[2024/05/19 13:05:17.932 +08:00] [INFO] [util.rs:601] ["PD failed to respond"] [err="Grpc(RpcFailure(RpcStatus { code: 14-UNAVAILABLE, message: \"failed to connect to all addresses\", details: [] }))"] [endpoints=127.0.0.1:2399] [thread_id=1]
[2024/05/19 13:05:17.932 +08:00] [WARN] [client.rs:169] ["validate PD endpoints failed"] [err="Other(\"[components/pd_client/src/util.rs:634]: PD cluster failed to respond\")"] [thread_id=1]
[2024/05/19 13:05:18.233 +08:00] [INFO] [util.rs:639] ["connecting to PD endpoint"] [endpoints=127.0.0.1:2399] [thread_id=1]
[2024/05/19 13:05:18.780 +08:00] [INFO] [util.rs:639] ["connecting to PD endpoint"] [endpoints=127.0.0.1:2399] [thread_id=1]
[2024/05/19 13:05:18.782 +08:00] [INFO] [util.rs:639] ["connecting to PD endpoint"] [endpoints=http://127.0.0.1:2399] [thread_id=1]
[2024/05/19 13:05:18.784 +08:00] [INFO] [util.rs:639] ["connecting to PD endpoint"] [endpoints=http://127.0.0.1:2399] [thread_id=1]
[2024/05/19 13:05:18.785 +08:00] [INFO] [util.rs:808] ["connected to PD member"] [endpoints=http://127.0.0.1:2399] [thread_id=1]
[2024/05/19 13:05:18.785 +08:00] [INFO] [util.rs:631] ["all PD endpoints are consistent"] [endpoints="[\"127.0.0.1:2399\"]"] [thread_id=1]
[2024/05/19 13:05:18.785 +08:00] [INFO] [common.rs:332] ["connect to PD cluster"] [cluster_id=7370572412132113403] [thread_id=1]
[2024/05/19 13:05:18.786 +08:00] [INFO] [mod.rs:2588] ["readpool.storage.use-unified-pool is not set, set to true by default"] [thread_id=1]
[2024/05/19 13:05:18.786 +08:00] [INFO] [mod.rs:2611] ["readpool.coprocessor.use-unified-pool is not set, set to true by default"] [thread_id=1]
[2024/05/19 13:05:18.786 +08:00] [WARN] [mod.rs:2010] ["raft-engine.batch-compression-threshold 8KiB should be adpative to the size of async-io. Set it to 4KiB instead."] [thread_id=1]
[2024/05/19 13:05:18.787 +08:00] [INFO] [config.rs:395] ["using default coprocessor quota"] [quota=ReadableSize(4294967296)] [thread_id=1]
[2024/05/19 13:05:18.788 +08:00] [INFO] [common.rs:452] ["beginning system configuration check"] [thread_id=1]
[2024/05/19 13:05:18.788 +08:00] [INFO] [config.rs:1077] ["data dir"] [mount_fs="FsInfo { tp: \"ext4\", opts: \"rw,seclabel,relatime\", mnt_dir: \"/home/jenkins/agent\", fsname: \"/dev/nvme0n1\" }"] [data_path=/home/jenkins/agent/workspace/pingcap/tidb/periodics_integration_test/tidb/tikv3] [thread_id=1]
[2024/05/19 13:05:18.789 +08:00] [INFO] [config.rs:1077] ["data dir"] [mount_fs="FsInfo { tp: \"ext4\", opts: \"rw,seclabel,relatime\", mnt_dir: \"/home/jenkins/agent\", fsname: \"/dev/nvme0n1\" }"] [data_path=/home/jenkins/agent/workspace/pingcap/tidb/periodics_integration_test/tidb/tikv3/raft] [thread_id=1]
[2024/05/19 13:05:18.789 +08:00] [INFO] [common.rs:120] ["using config"] [config="{\"slow-log-file\":\"\",\"slow-log-threshold\":\"1s\",\"panic-when-unexpected-key-or-data\":false,\"abort-on-panic\":false,\"memory-usage-limit\":\"25769803775B\",\"memory-usage-high-water\":0.9,\"log\":{\"level\":\"info\",\"format\":\"text\",\"enable-timestamp\":true,\"file\":{\"filename\":\"tikv3.log\",\"max-size\":300,\"max-days\":0,\"max-backups\":0}},\"memory\":{\"enable-heap-profiling\":true,\"profiling-sample-per-bytes\":\"512KiB\",\"enable-thread-exclusive-arena\":true},\"quota\":{\"foreground-cpu-time\":0,\"foreground-write-bandwidth\":\"0KiB\",\"foreground-read-bandwidth\":\"0KiB\",\"max-delay-duration\":\"500ms\",\"background-cpu-time\":0,\"background-write-bandwidth\":\"0KiB\",\"background-read-bandwidth\":\"0KiB\",\"enable-auto-tune\":false},\"readpool\":{\"unified\":{\"min-thread-count\":1,\"max-thread-count\":6,\"stack-size\":\"10MiB\",\"max-tasks-per-worker\":2000,\"auto-adjust-pool-size\":false},\"storage\":{\"use-unified-pool\":true,\"high-concurrency\":4,\"normal-concurrency\":4,\"low-concurrency\":4,\"max-tasks-per-worker-high\":2000,\"max-tasks-per-worker-normal\":2000,\"max-tasks-per-worker-low\":2000,\"stack-size\":\"10MiB\"},\"coprocessor\":{\"use-unified-pool\":true,\"high-concurrency\":6,\"normal-concurrency\":6,\"low-concurrency\":6,\"max-tasks-per-worker-high\":2000,\"max-tasks-per-worker-normal\":2000,\"max-tasks-per-worker-low\":2000,\"stack-size\":\"10MiB\"}},\"server\":{\"addr\":\"0.0.0.0:20180\",\"advertise-addr\":\"127.0.0.1:20180\",\"status-addr\":\"127.0.0.1:20180\",\"advertise-status-addr\":\"127.0.0.1:20185\",\"status-thread-pool-size\":1,\"max-grpc-send-msg-len\":10485760,\"raft-client-grpc-send-msg-buffer\":524288,\"raft-client-queue-size\":8192,\"raft-msg-max-batch-size\":128,\"grpc-compression-type\":\"none\",\"grpc-gzip-compression-level\":2,\"grpc-min-message-size-to-compress\":4096,\"grpc-concurrency\":5,\"grpc-concurrent-stream\":1024,\"grpc-raft-conn-num\":1,\"grpc-memory-pool-quota\":\"9223372036854775807B\",\"grpc-stream-initial-window-size\":\"2MiB\",\"grpc-keepalive-time\":\"10s\",\"grpc-keepalive-timeout\":\"3s\",\"concurrent-send-snap-limit\":32,\"concurrent-recv-snap-limit\":32,\"end-point-recursion-limit\":1000,\"end-point-stream-channel-size\":8,\"end-point-batch-row-limit\":64,\"end-point-stream-batch-row-limit\":128,\"end-point-enable-batch-if-possible\":true,\"end-point-request-max-handle-duration\":\"1m\",\"end-point-max-concurrency\":8,\"end-point-perf-level\":0,\"end-point-memory-quota\":\"4GiB\",\"snap-io-max-bytes-per-sec\":\"100MiB\",\"snap-max-total-size\":\"0KiB\",\"stats-concurrency\":1,\"heavy-load-threshold\":75,\"heavy-load-wait-duration\":null,\"enable-request-batch\":true,\"background-thread-count\":2,\"end-point-slow-log-threshold\":\"1s\",\"forward-max-connections-per-address\":4,\"reject-messages-on-memory-ratio\":0.2,\"simplify-metrics\":false,\"health-feedback-interval\":\"1s\",\"labels\":{}},\"storage\":{\"data-dir\":\"/home/jenkins/agent/workspace/pingcap/tidb/periodics_integration_test/tidb/tikv3\",\"engine\":\"raft-kv\",\"gc-ratio-threshold\":1.1,\"max-key-size\":8192,\"scheduler-concurrency\":524288,\"scheduler-worker-pool-size\":4,\"scheduler-pending-write-threshold\":\"100MiB\",\"reserve-space\":\"5GiB\",\"reserve-raft-space\":\"1GiB\",\"enable-async-apply-prewrite\":false,\"api-version\":1,\"enable-ttl\":false,\"background-error-recovery-window\":\"1h\",\"ttl-check-poll-interval\":\"12h\",\"txn-status-cache-capacity\":5120000,\"memory-quota\":\"256MiB\",\"flow-control\":{\"enable\":true,\"soft-pending-compaction-bytes-limit\":\"192GiB\",\"hard-pending-compaction-bytes-limit\":\"1TiB\",\"memtables-threshold\":5,\"l0-files-threshold\":20},\"block-cache\":{\"shared\":null,\"capacity\":\"15461882265B\",\"num-shard-bits\":6,\"strict-capacity-limit\":false,\"high-pri-pool-ratio\":0.8,\"low-pri-pool-ratio\":0.2,\"memory-allocator\":\"nodump\"},\"io-rate-limit\":{\"max-bytes-per-sec\":\"0KiB\",\"mode\":\"write-only\",\"strict\":false,\"foreground-read-priority\":\"high\",\"foreground-write-priority\":\"high\",\"flush-priority\":\"high\",\"level-zero-compaction-priority\":\"medium\",\"compaction-priority\":\"low\",\"replication-priority\":\"high\",\"load-balance-priority\":\"high\",\"gc-priority\":\"high\",\"import-priority\":\"medium\",\"export-priority\":\"medium\",\"other-priority\":\"high\"}},\"pd\":{\"endpoints\":[\"127.0.0.1:2399\"],\"retry-interval\":\"300ms\",\"retry-max-count\":9223372036854775807,\"retry-log-every\":10,\"update-interval\":\"10m\",\"enable-forwarding\":false},\"metric\":{\"job\":\"tikv\"},\"raftstore\":{\"prevote\":true,\"raftdb-path\":\"/home/jenkins/agent/workspace/pingcap/tidb/periodics_integration_test/tidb/tikv3/raft\",\"capacity\":\"0KiB\",\"raft-base-tick-interval\":\"1s\",\"raft-heartbeat-ticks\":2,\"raft-election-timeout-ticks\":10,\"raft-min-election-timeout-ticks\":10,\"raft-max-election-timeout-ticks\":20,\"raft-max-size-per-msg\":\"1MiB\",\"raft-max-inflight-msgs\":256,\"raft-entry-max-size\":\"8MiB\",\"raft-log-compact-sync-interval\":\"2s\",\"raft-log-gc-tick-interval\":\"3s\",\"request-voter-replicated-index-interval\":\"5m\",\"raft-log-gc-threshold\":50,\"raft-log-gc-count-limit\":73728,\"raft-log-gc-size-limit\":\"72MiB\",\"max-apply-unpersisted-log-limit\":1024,\"follower-read-max-log-gap\":100,\"raft-log-reserve-max-ticks\":6,\"raft-engine-purge-interval\":\"10s\",\"max-manual-flush-rate\":3.0,\"raft-entry-cache-life-time\":\"30s\",\"split-region-check-tick-interval\":\"10s\",\"region-split-check-diff\":\"6MiB\",\"region-compact-check-interval\":\"5m\",\"region-compact-check-step\":100,\"region-compact-min-tombstones\":10000,\"region-compact-tombstones-percent\":30,\"region-compact-min-redundant-rows\":50000,\"region-compact-redundant-rows-percent\":20,\"pd-heartbeat-tick-interval\":\"1m\",\"pd-store-heartbeat-tick-interval\":\"10s\",\"pd-report-min-resolved-ts-interval\":\"1s\",\"snap-mgr-gc-tick-interval\":\"1m\",\"snap-gc-timeout\":\"4h\",\"snap-wait-split-duration\":\"34s\",\"lock-cf-compact-interval\":\"10m\",\"lock-cf-compact-bytes-threshold\":\"256MiB\",\"periodic-full-compact-start-times\":[],\"periodic-full-compact-start-max-cpu\":0.1,\"notify-capacity\":40960,\"messages-per-tick\":4096,\"max-peer-down-duration\":\"10m\",\"max-leader-missing-duration\":\"2h\",\"abnormal-leader-missing-duration\":\"10m\",\"peer-stale-state-check-interval\":\"5m\",\"gc-peer-check-interval\":\"1m\",\"leader-transfer-max-log-lag\":128,\"snap-apply-batch-size\":\"10MiB\",\"snap-apply-copy-symlink\":false,\"region-worker-tick-interval\":\"1s\",\"clean-stale-ranges-tick\":10,\"consistency-check-interval\":\"0s\",\"report-region-flow-interval\":\"1m\",\"raft-store-max-leader-lease\":\"9s\",\"check-leader-lease-interval\":\"2s250ms\",\"renew-leader-lease-advance-duration\":\"2s250ms\",\"right-derive-when-split\":true,\"merge-max-log-gap\":10,\"merge-check-tick-interval\":\"2s\",\"use-delete-range\":false,\"snap-generator-pool-size\":2,\"cleanup-import-sst-interval\":\"10m\",\"local-read-batch-size\":1024,\"apply-max-batch-size\":256,\"apply-pool-size\":2,\"apply-reschedule-duration\":\"5s\",\"apply-low-priority-pool-size\":1,\"store-max-batch-size\":256,\"store-pool-size\":2,\"store-reschedule-duration\":\"5s\",\"store-low-priority-pool-size\":0,\"store-io-pool-size\":1,\"store-io-notify-capacity\":40960,\"future-poll-size\":1,\"hibernate-regions\":true,\"dev-assert\":false,\"apply-yield-duration\":\"500ms\",\"apply-yield-write-size\":\"32KiB\",\"perf-level\":0,\"evict-cache-on-memory-ratio\":0.1,\"cmd-batch\":true,\"cmd-batch-concurrent-ready-max-count\":1,\"raft-write-size-limit\":\"1MiB\",\"waterfall-metrics\":true,\"io-reschedule-concurrent-max-count\":4,\"io-reschedule-hotpot-duration\":\"5s\",\"inspect-interval\":\"100ms\",\"inspect-cpu-util-thd\":0.4,\"slow-trend-unsensitive-cause\":10.0,\"slow-trend-unsensitive-result\":0.5,\"slow-trend-network-io-factor\":0.0,\"reactive-memory-lock-tick-interval\":\"2s\",\"reactive-memory-lock-timeout-tick\":5,\"report-region-buckets-tick-interval\":\"10s\",\"check-long-uncommitted-interval\":\"10s\",\"long-uncommitted-base-threshold\":\"20s\",\"max-entry-cache-warmup-duration\":\"1s\",\"max-snapshot-file-raw-size\":\"100MiB\",\"unreachable-backoff\":\"10s\",\"enable-v2-compatible-learner\":false,\"min-pending-apply-region-count\":10,\"skip-manual-compaction-in-clean-up-worker\":false},\"coprocessor\":{\"split-region-on-table\":false,\"batch-split-limit\":10,\"region-max-size\":\"144MiB\",\"region-split-size\":\"96MiB\",\"region-max-keys\":1440000,\"region-split-keys\":960000,\"consistency-check-method\":\"mvcc\",\"enable-region-bucket\":null,\"region-bucket-size\":\"50MiB\",\"region-size-threshold-for-approximate\":\"750MiB\",\"prefer-approximate-bucket\":true,\"region-bucket-merge-size-ratio\":0.33},\"coprocessor-v2\":{\"coprocessor-plugin-directory\":null},\"rocksdb\":{\"info-log-level\":\"info\",\"wal-recovery-mode\":2,\"wal-dir\":\"\",\"wal-ttl-seconds\":0,\"wal-size-limit\":\"0KiB\",\"max-total-wal-size\":\"4GiB\",\"max-background-jobs\":7,\"max-background-flushes\":2,\"max-manifest-file-size\":\"128MiB\",\"create-if-missing\":true,\"max-open-files\":40960,\"stats-dump-period\":\"10m\",\"compaction-readahead-size\":\"0KiB\",\"info-log-max-size\":\"1GiB\",\"info-log-roll-time\":\"0s\",\"info-log-keep-log-file-num\":10,\"info-log-dir\":\"\",\"rate-bytes-per-sec\":\"10GiB\",\"rate-limiter-refill-period\":\"100ms\",\"rate-limiter-mode\":2,\"rate-limiter-auto-tuned\":true,\"bytes-per-sync\":\"1MiB\",\"wal-bytes-per-sync\":\"512KiB\",\"max-sub-compactions\":3,\"writable-file-max-buffer-size\":\"1MiB\",\"use-direct-io-for-flush-and-compaction\":false,\"enable-pipelined-write\":false,\"enable-multi-batch-write\":null,\"enable-unordered-write\":false,\"allow-concurrent-memtable-write\":true,\"write-buffer-limit\":null,\"track-and-verify-wals-in-manifest\":true,\"defaultcf\":{\"block-size\":\"32KiB\",\"block-cache-size\":null,\"disable-block-cache\":false,\"cache-index-and-filter-blocks\":true,\"pin-l0-filter-and-index-blocks\":true,\"use-bloom-filter\":true,\"optimize-filters-for-hits\":true,\"optimize-filters-for-memory\":false,\"whole-key-filtering\":true,\"bloom-filter-bits-per-key\":10,\"block-based-bloom-filter\":false,\"ribbon-filter-above-level\":null,\"read-amp-bytes-per-bit\":0,\"compression-per-level\":[\"no\",\"no\",\"lz4\",\"lz4\",\"lz4\",\"zstd\",\"zstd\"],\"write-buffer-size\":\"128MiB\",\"write-buffer-limit\":null,\"max-write-buffer-number\":5,\"min-write-buffer-number-to-merge\":1,\"max-bytes-for-level-base\":\"512MiB\",\"target-file-size-base\":null,\"level0-file-num-compaction-trigger\":4,\"level0-slowdown-writes-trigger\":20,\"level0-stop-writes-trigger\":20,\"max-compaction-bytes\":\"2GiB\",\"compaction-pri\":3,\"dynamic-level-bytes\":true,\"num-levels\":7,\"max-bytes-for-level-multiplier\":10,\"compaction-style\":0,\"disable-auto-compactions\":false,\"disable-write-stall\":true,\"soft-pending-compaction-bytes-limit\":\"192GiB\",\"hard-pending-compaction-bytes-limit\":\"1TiB\",\"force-consistency-checks\":false,\"prop-size-index-distance\":4194304,\"prop-keys-index-distance\":40960,\"enable-doubly-skiplist\":true,\"enable-compaction-guard\":true,\"compaction-guard-min-output-file-size\":\"8MiB\",\"compaction-guard-max-output-file-size\":\"128MiB\",\"bottommost-level-compression\":\"zstd\",\"bottommost-zstd-compression-dict-size\":0,\"bottommost-zstd-compression-sample-size\":0,\"prepopulate-block-cache\":\"disabled\",\"format-version\":null,\"checksum\":\"crc32c\",\"max-compactions\":null,\"ttl\":null,\"periodic-compaction-seconds\":null,\"titan\":{\"min-blob-size\":\"32KiB\",\"blob-file-compression\":\"zstd\",\"zstd-dict-size\":\"0KiB\",\"shared-blob-cache\":true,\"blob-cache-size\":\"0KiB\",\"min-gc-batch-size\":\"16MiB\",\"max-gc-batch-size\":\"64MiB\",\"discardable-ratio\":0.5,\"merge-small-file-threshold\":\"8MiB\",\"blob-run-mode\":\"normal\",\"level-merge\":false,\"range-merge\":true,\"max-sorted-runs\":20}},\"writecf\":{\"block-size\":\"32KiB\",\"block-cache-size\":null,\"disable-block-cache\":false,\"cache-index-and-filter-blocks\":true,\"pin-l0-filter-and-index-blocks\":true,\"use-bloom-filter\":true,\"optimize-filters-for-hits\":false,\"optimize-filters-for-memory\":false,\"whole-key-filtering\":false,\"bloom-filter-bits-per-key\":10,\"block-based-bloom-filter\":false,\"ribbon-filter-above-level\":null,\"read-amp-bytes-per-bit\":0,\"compression-per-level\":[\"no\",\"no\",\"lz4\",\"lz4\",\"lz4\",\"zstd\",\"zstd\"],\"write-buffer-size\":\"128MiB\",\"write-buffer-limit\":null,\"max-write-buffer-number\":5,\"min-write-buffer-number-to-merge\":1,\"max-bytes-for-level-base\":\"512MiB\",\"target-file-size-base\":null,\"level0-file-num-compaction-trigger\":4,\"level0-slowdown-writes-trigger\":20,\"level0-stop-writes-trigger\":20,\"max-compaction-bytes\":\"2GiB\",\"compaction-pri\":3,\"dynamic-level-bytes\":true,\"num-levels\":7,\"max-bytes-for-level-multiplier\":10,\"compaction-style\":0,\"disable-auto-compactions\":false,\"disable-write-stall\":true,\"soft-pending-compaction-bytes-limit\":\"192GiB\",\"hard-pending-compaction-bytes-limit\":\"1TiB\",\"force-consistency-checks\":false,\"prop-size-index-distance\":4194304,\"prop-keys-index-distance\":40960,\"enable-doubly-skiplist\":true,\"enable-compaction-guard\":true,\"compaction-guard-min-output-file-size\":\"8MiB\",\"compaction-guard-max-output-file-size\":\"128MiB\",\"bottommost-level-compression\":\"zstd\",\"bottommost-zstd-compression-dict-size\":0,\"bottommost-zstd-compression-sample-size\":0,\"prepopulate-block-cache\":\"disabled\",\"format-version\":null,\"checksum\":\"crc32c\",\"max-compactions\":null,\"ttl\":null,\"periodic-compaction-seconds\":null,\"titan\":{\"min-blob-size\":null,\"blob-file-compression\":\"zstd\",\"zstd-dict-size\":\"0KiB\",\"shared-blob-cache\":true,\"blob-cache-size\":\"0KiB\",\"min-gc-batch-size\":\"16MiB\",\"max-gc-batch-size\":\"64MiB\",\"discardable-ratio\":0.5,\"merge-small-file-threshold\":\"8MiB\",\"blob-run-mode\":\"read-only\",\"level-merge\":false,\"range-merge\":true,\"max-sorted-runs\":20}},\"lockcf\":{\"block-size\":\"16KiB\",\"block-cache-size\":null,\"disable-block-cache\":false,\"cache-index-and-filter-blocks\":true,\"pin-l0-filter-and-index-blocks\":true,\"use-bloom-filter\":true,\"optimize-filters-for-hits\":false,\"optimize-filters-for-memory\":false,\"whole-key-filtering\":true,\"bloom-filter-bits-per-key\":10,\"block-based-bloom-filter\":false,\"ribbon-filter-above-level\":null,\"read-amp-bytes-per-bit\":0,\"compression-per-level\":[\"no\",\"no\",\"no\",\"no\",\"no\",\"no\",\"no\"],\"write-buffer-size\":\"32MiB\",\"write-buffer-limit\":null,\"max-write-buffer-number\":5,\"min-write-buffer-number-to-merge\":1,\"max-bytes-for-level-base\":\"128MiB\",\"target-file-size-base\":null,\"level0-file-num-compaction-trigger\":1,\"level0-slowdown-writes-trigger\":20,\"level0-stop-writes-trigger\":20,\"max-compaction-bytes\":\"2GiB\",\"compaction-pri\":0,\"dynamic-level-bytes\":true,\"num-levels\":7,\"max-bytes-for-level-multiplier\":10,\"compaction-style\":0,\"disable-auto-compactions\":false,\"disable-write-stall\":true,\"soft-pending-compaction-bytes-limit\":\"192GiB\",\"hard-pending-compaction-bytes-limit\":\"1TiB\",\"force-consistency-checks\":false,\"prop-size-index-distance\":4194304,\"prop-keys-index-distance\":40960,\"enable-doubly-skiplist\":true,\"enable-compaction-guard\":null,\"compaction-guard-min-output-file-size\":\"8MiB\",\"compaction-guard-max-output-file-size\":\"128MiB\",\"bottommost-level-compression\":\"disable\",\"bottommost-zstd-compression-dict-size\":0,\"bottommost-zstd-compression-sample-size\":0,\"prepopulate-block-cache\":\"disabled\",\"format-version\":null,\"checksum\":\"crc32c\",\"max-compactions\":null,\"ttl\":null,\"periodic-compaction-seconds\":null,\"titan\":{\"min-blob-size\":null,\"blob-file-compression\":\"zstd\",\"zstd-dict-size\":\"0KiB\",\"shared-blob-cache\":true,\"blob-cache-size\":\"0KiB\",\"min-gc-batch-size\":\"16MiB\",\"max-gc-batch-size\":\"64MiB\",\"discardable-ratio\":0.5,\"merge-small-file-threshold\":\"8MiB\",\"blob-run-mode\":\"read-only\",\"level-merge\":false,\"range-merge\":true,\"max-sorted-runs\":20}},\"raftcf\":{\"block-size\":\"16KiB\",\"block-cache-size\":null,\"disable-block-cache\":false,\"cache-index-and-filter-blocks\":true,\"pin-l0-filter-and-index-blocks\":true,\"use-bloom-filter\":true,\"optimize-filters-for-hits\":true,\"optimize-filters-for-memory\":false,\"whole-key-filtering\":true,\"bloom-filter-bits-per-key\":10,\"block-based-bloom-filter\":false,\"ribbon-filter-above-level\":null,\"read-amp-bytes-per-bit\":0,\"compression-per-level\":[\"no\",\"no\",\"no\",\"no\",\"no\",\"no\",\"no\"],\"write-buffer-size\":\"128MiB\",\"write-buffer-limit\":null,\"max-write-buffer-number\":5,\"min-write-buffer-number-to-merge\":1,\"max-bytes-for-level-base\":\"128MiB\",\"target-file-size-base\":null,\"level0-file-num-compaction-trigger\":1,\"level0-slowdown-writes-trigger\":20,\"level0-stop-writes-trigger\":20,\"max-compaction-bytes\":\"2GiB\",\"compaction-pri\":0,\"dynamic-level-bytes\":true,\"num-levels\":7,\"max-bytes-for-level-multiplier\":10,\"compaction-style\":0,\"disable-auto-compactions\":false,\"disable-write-stall\":true,\"soft-pending-compaction-bytes-limit\":\"192GiB\",\"hard-pending-compaction-bytes-limit\":\"1TiB\",\"force-consistency-checks\":false,\"prop-size-index-distance\":4194304,\"prop-keys-index-distance\":40960,\"enable-doubly-skiplist\":true,\"enable-compaction-guard\":null,\"compaction-guard-min-output-file-size\":\"8MiB\",\"compaction-guard-max-output-file-size\":\"128MiB\",\"bottommost-level-compression\":\"disable\",\"bottommost-zstd-compression-dict-size\":0,\"bottommost-zstd-compression-sample-size\":0,\"prepopulate-block-cache\":\"disabled\",\"format-version\":null,\"checksum\":\"crc32c\",\"max-compactions\":null,\"ttl\":null,\"periodic-compaction-seconds\":null,\"titan\":{\"min-blob-size\":null,\"blob-file-compression\":\"zstd\",\"zstd-dict-size\":\"0KiB\",\"shared-blob-cache\":true,\"blob-cache-size\":\"0KiB\",\"min-gc-batch-size\":\"16MiB\",\"max-gc-batch-size\":\"64MiB\",\"discardable-ratio\":0.5,\"merge-small-file-threshold\":\"8MiB\",\"blob-run-mode\":\"read-only\",\"level-merge\":false,\"range-merge\":true,\"max-sorted-runs\":20}},\"titan\":{\"enabled\":true,\"dirname\":\"\",\"disable-gc\":false,\"max-background-gc\":1,\"purge-obsolete-files-period\":\"10s\"}},\"raftdb\":{\"wal-recovery-mode\":2,\"wal-dir\":\"\",\"wal-ttl-seconds\":0,\"wal-size-limit\":\"0KiB\",\"max-total-wal-size\":\"4GiB\",\"max-background-jobs\":4,\"max-background-flushes\":1,\"max-manifest-file-size\":\"20MiB\",\"create-if-missing\":true,\"max-open-files\":40960,\"stats-dump-period\":\"10m\",\"compaction-readahead-size\":\"0KiB\",\"info-log-max-size\":\"1GiB\",\"info-log-roll-time\":\"0s\",\"info-log-keep-log-file-num\":10,\"info-log-dir\":\"\",\"info-log-level\":\"info\",\"max-sub-compactions\":2,\"writable-file-max-buffer-size\":\"1MiB\",\"use-direct-io-for-flush-and-compaction\":false,\"enable-pipelined-write\":true,\"enable-unordered-write\":false,\"allow-concurrent-memtable-write\":true,\"bytes-per-sync\":\"1MiB\",\"wal-bytes-per-sync\":\"512KiB\",\"defaultcf\":{\"block-size\":\"64KiB\",\"block-cache-size\":null,\"disable-block-cache\":false,\"cache-index-and-filter-blocks\":true,\"pin-l0-filter-and-index-blocks\":true,\"use-bloom-filter\":false,\"optimize-filters-for-hits\":true,\"optimize-filters-for-memory\":false,\"whole-key-filtering\":true,\"bloom-filter-bits-per-key\":10,\"block-based-bloom-filter\":false,\"ribbon-filter-above-level\":null,\"read-amp-bytes-per-bit\":0,\"compression-per-level\":[\"no\",\"no\",\"lz4\",\"lz4\",\"lz4\",\"zstd\",\"zstd\"],\"write-buffer-size\":\"128MiB\",\"write-buffer-limit\":null,\"max-write-buffer-number\":5,\"min-write-buffer-number-to-merge\":1,\"max-bytes-for-level-base\":\"512MiB\",\"target-file-size-base\":null,\"level0-file-num-compaction-trigger\":4,\"level0-slowdown-writes-trigger\":20,\"level0-stop-writes-trigger\":20,\"max-compaction-bytes\":\"2GiB\",\"compaction-pri\":0,\"dynamic-level-bytes\":true,\"num-levels\":7,\"max-bytes-for-level-multiplier\":10,\"compaction-style\":0,\"disable-auto-compactions\":false,\"disable-write-stall\":false,\"soft-pending-compaction-bytes-limit\":\"192GiB\",\"hard-pending-compaction-bytes-limit\":\"1TiB\",\"force-consistency-checks\":false,\"prop-size-index-distance\":4194304,\"prop-keys-index-distance\":40960,\"enable-doubly-skiplist\":true,\"enable-compaction-guard\":null,\"compaction-guard-min-output-file-size\":\"8MiB\",\"compaction-guard-max-output-file-size\":\"128MiB\",\"bottommost-level-compression\":\"disable\",\"bottommost-zstd-compression-dict-size\":0,\"bottommost-zstd-compression-sample-size\":0,\"prepopulate-block-cache\":\"disabled\",\"format-version\":2,\"checksum\":\"crc32c\",\"max-compactions\":null,\"ttl\":null,\"periodic-compaction-seconds\":null,\"titan\":{\"min-blob-size\":null,\"blob-file-compression\":\"zstd\",\"zstd-dict-size\":\"0KiB\",\"shared-blob-cache\":true,\"blob-cache-size\":\"0KiB\",\"min-gc-batch-size\":\"16MiB\",\"max-gc-batch-size\":\"64MiB\",\"discardable-ratio\":0.5,\"merge-small-file-threshold\":\"8MiB\",\"blob-run-mode\":\"normal\",\"level-merge\":false,\"range-merge\":true,\"max-sorted-runs\":20}},\"titan\":{\"enabled\":false,\"dirname\":\"\",\"disable-gc\":false,\"max-background-gc\":1,\"purge-obsolete-files-period\":\"10s\"}},\"raft-engine\":{\"enable\":true,\"dir\":\"/home/jenkins/agent/workspace/pingcap/tidb/periodics_integration_test/tidb/tikv3/raft-engine\",\"spill-dir\":null,\"recovery-mode\":\"tolerate-corrupted-tail-records\",\"recovery-read-block-size\":\"16KiB\",\"recovery-threads\":4,\"batch-compression-threshold\":\"4KiB\",\"compression-level\":null,\"bytes-per-sync\":null,\"format-version\":2,\"target-file-size\":\"128MiB\",\"purge-threshold\":\"10GiB\",\"purge-rewrite-threshold\":\"1GiB\",\"purge-rewrite-garbage-ratio\":0.6,\"memory-limit\":\"5153960755B\",\"enable-log-recycle\":true,\"prefill-for-recycle\":false,\"prefill-limit\":null},\"security\":{\"ca-path\":\"\",\"cert-path\":\"\",\"key-path\":\"\",\"cert-allowed-cn\":[],\"redact-info-log\":null,\"encryption\":{\"data-encryption-method\":\"plaintext\",\"data-key-rotation-period\":\"7d\",\"enable-file-dictionary-log\":true,\"file-dictionary-rewrite-threshold\":1000000,\"master-key\":{\"type\":\"plaintext\"},\"previous-master-key\":{\"type\":\"plaintext\"}}},\"import\":{\"num-threads\":8,\"stream-channel-window\":128,\"import-mode-timeout\":\"10m\",\"memory-use-ratio\":0.3},\"backup\":{\"num-threads\":4,\"batch-size\":8,\"sst-max-size\":\"144MiB\",\"enable-auto-tune\":true,\"auto-tune-remain-threads\":2,\"auto-tune-refresh-interval\":\"1m\",\"io-thread-size\":2,\"s3-multi-part-size\":\"5MiB\",\"hadoop\":{\"home\":\"\",\"linux-user\":\"\"}},\"log-backup\":{\"min-ts-interval\":\"10s\",\"max-flush-interval\":\"3m\",\"num-threads\":4,\"enable\":true,\"temp-path\":\"/home/jenkins/agent/workspace/pingcap/tidb/periodics_integration_test/tidb/tikv3/log-backup-temp\",\"file-size-limit\":\"256MiB\",\"initial-scan-pending-memory-quota\":\"512MiB\",\"initial-scan-rate-limit\":\"60MiB\",\"initial-scan-concurrency\":6},\"pessimistic-txn\":{\"wait-for-lock-timeout\":\"1s\",\"wake-up-delay-duration\":\"20ms\",\"pipelined\":false,\"in-memory\":true},\"gc\":{\"ratio-threshold\":1.1,\"batch-keys\":512,\"max-write-bytes-per-sec\":\"0KiB\",\"enable-compaction-filter\":true,\"compaction-filter-skip-version-check\":false,\"num-threads\":1},\"split\":{\"qps-threshold\":3000,\"split-balance-score\":0.25,\"split-contained-score\":0.5,\"detect-times\":10,\"sample-num\":20,\"sample-threshold\":100,\"byte-threshold\":31457280,\"grpc-thread-cpu-overload-threshold-ratio\":0.5,\"unified-read-pool-thread-cpu-overload-threshold-ratio\":0.8,\"region-cpu-overload-threshold-ratio\":0.25},\"cdc\":{\"min-ts-interval\":\"1s\",\"hibernate-regions-compatible\":true,\"incremental-scan-threads\":4,\"incremental-scan-concurrency\":6,\"incremental-scan-concurrency-limit\":10000,\"incremental-scan-speed-limit\":\"128MiB\",\"incremental-fetch-speed-limit\":\"512MiB\",\"incremental-scan-ts-filter-ratio\":0.2,\"tso-worker-threads\":1,\"sink-memory-quota\":\"512MiB\",\"old-value-cache-memory-quota\":\"512MiB\"},\"resolved-ts\":{\"enable\":true,\"advance-ts-interval\":\"20s\",\"scan-lock-pool-size\":2,\"memory-quota\":\"256MiB\",\"incremental-scan-concurrency\":6},\"resource-metering\":{\"receiver-address\":\"\",\"report-receiver-interval\":\"1m\",\"max-resource-groups\":100,\"precision\":\"1s\"},\"causal-ts\":{\"renew-interval\":\"100ms\",\"renew-batch-min-size\":100,\"renew-batch-max-size\":8192,\"alloc-ahead-buffer\":\"3s\"},\"resource-control\":{\"enabled\":true},\"range-cache-engine\":{\"enabled\":false,\"gc-interval\":\"3m\",\"soft-limit-threshold\":null,\"hard-limit-threshold\":null}}"] [thread_id=1]
[2024/05/19 13:05:18.790 +08:00] [INFO] [resource_group.rs:145] ["add resource group"] [ru=2147483647] [name=default] [thread_id=1]
[2024/05/19 13:05:18.790 +08:00] [WARN] [worker.rs:353] ["adjust duration too small, skip adjustment."] [dur=0ns] [thread_id=18]
[2024/05/19 13:05:18.790 +08:00] [INFO] [resource_group.rs:145] ["add resource group"] [ru=2147483647] [name=default] [thread_id=17]
[2024/05/19 13:05:18.790 +08:00] [INFO] [service.rs:70] ["pd meta client creating watch stream."] [rev=12] [path=resource_group/settings] [thread_id=17]
[2024/05/19 13:05:18.790 +08:00] [INFO] [service.rs:193] ["load controller config"] [config="RequestUnitConfig { read_base_cost: 0.125, read_cost_per_byte: 1.52587890625e-5, write_base_cost: 1.0, write_cost_per_byte: 0.0009765625, read_cpu_ms_cost: 0.3333333333333333 }"] [thread_id=18]
[2024/05/19 13:05:18.790 +08:00] [WARN] [common.rs:209] ["failed to remove space holder on starting: No such file or directory (os error 2)"] [thread_id=1]
[2024/05/19 13:05:18.828 +08:00] [INFO] [mod.rs:130] ["encryption: none of key dictionary and file dictionary are found."] [thread_id=1]
[2024/05/19 13:05:18.828 +08:00] [INFO] [mod.rs:549] ["encryption is disabled."] [thread_id=1]
[2024/05/19 13:05:18.828 +08:00] [INFO] [engine.rs:93] ["Recovering raft logs takes 200.418µs"] [thread_id=1]
[2024/05/19 13:05:18.888 +08:00] [INFO] [mod.rs:298] ["Storage started."] [thread_id=1]
[2024/05/19 13:05:18.890 +08:00] [INFO] [snapshot_backup.rs:106] ["registered reject ingest and admin coprocessor to TiKV."] [thread_id=1]
[2024/05/19 13:05:18.890 +08:00] [INFO] [endpoint.rs:1138] ["create tokio runtime for backup stream"] [thread_count=2] [thread_name=backup-stream] [thread_id=1]
[2024/05/19 13:05:18.890 +08:00] [INFO] [endpoint.rs:154] ["the endpoint of stream backup started"] [path=/home/jenkins/agent/workspace/pingcap/tidb/periodics_integration_test/tidb/tikv3/log-backup-temp] [thread_id=1]
[2024/05/19 13:05:18.891 +08:00] [INFO] [checkpoint_manager.rs:67] ["subscription manager started!"] [thread_id=74]
[2024/05/19 13:05:18.891 +08:00] [INFO] [sst_importer.rs:187] ["sst importer memory limit when apply"] [size=10307921510] [ratio=0.3] [thread_id=1]
[2024/05/19 13:05:18.891 +08:00] [INFO] [endpoint.rs:142] ["started task watcher!"] [thread_id=74]
[2024/05/19 13:05:18.891 +08:00] [INFO] [pd.rs:145] ["pd meta client creating watch stream."] [rev=13] [keys=Prefix(K(/tidb/br-stream/info/))] [thread_id=73]
[2024/05/19 13:05:18.891 +08:00] [INFO] [endpoint.rs:363] ["start watching the task changes."] [from_rev=12] [thread_id=73]
[2024/05/19 13:05:18.891 +08:00] [INFO] [pd.rs:145] ["pd meta client creating watch stream."] [rev=13] [keys=Prefix(K(/tidb/br-stream/pause/))] [thread_id=74]
[2024/05/19 13:05:18.891 +08:00] [INFO] [endpoint.rs:414] ["start watching the pausing events."] [from_rev=12] [thread_id=74]
[2024/05/19 13:05:18.898 +08:00] [INFO] [raft_server.rs:187] ["trying to bootstrap cluster"] [region="id: 2 region_epoch { conf_ver: 1 version: 1 } peers { id: 3 store_id: 1 }"] [store_id=1] [thread_id=1]
[2024/05/19 13:05:18.905 +08:00] [INFO] [raft_server.rs:404] ["bootstrap cluster ok"] [cluster_id=7370572412132113403] [thread_id=1]
[2024/05/19 13:05:18.905 +08:00] [INFO] [raft_server.rs:196] ["put store to PD"] [store="id: 1 address: \"127.0.0.1:20180\" version: \"8.2.0-alpha\" peer_address: \"127.0.0.1:20180\" status_address: \"127.0.0.1:20185\" git_hash: \"a1a8672e93c4da9c2dc5704151314d92e1bc4c04\" start_timestamp: 1716095118 deploy_path: \"/home/jenkins/agent/workspace/pingcap/tidb/periodics_integration_test/tidb/bin\""] [thread_id=1]
[2024/05/19 13:05:18.907 +08:00] [INFO] [raft_server.rs:335] ["initializing replication mode"] [store_id=1] [status=Some()] [thread_id=1]
[2024/05/19 13:05:18.907 +08:00] [INFO] [replication_mode.rs:55] ["associated store labels"] [labels="[]"] [store_id=1] [thread_id=1]
[2024/05/19 13:05:18.907 +08:00] [INFO] [raft_server.rs:469] ["start raft store thread"] [store_id=1] [thread_id=1]
[2024/05/19 13:05:18.908 +08:00] [INFO] [snap.rs:1461] ["Initializing SnapManager, encryption is enabled: false"] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [write.rs:1041] ["starting store writer 0"] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [peer.rs:275] ["create peer"] [peer_id=3] [region_id=2] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [raft.rs:2684] ["switched to configuration"] [config="Configuration { voters: Configuration { incoming: Configuration { voters: {3} }, outgoing: Configuration { voters: {} } }, learners: {}, learners_next: {}, auto_leave: false }"] [raft_id=3] [region_id=2] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [raft.rs:1151] ["became follower at term 5"] [term=5] [raft_id=3] [region_id=2] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [raft.rs:387] [newRaft] [peers="Configuration { incoming: Configuration { voters: {3} }, outgoing: Configuration { voters: {} } }"] ["last term"=5] ["last index"=5] [applied=5] [commit=5] [term=5] [raft_id=3] [region_id=2] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [raw_node.rs:315] ["RawNode created with id 3."] [id=3] [raft_id=3] [region_id=2] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [raft.rs:1556] ["starting a new election"] [term=5] [raft_id=3] [region_id=2] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [raft.rs:1201] ["became pre-candidate at term 5"] [term=5] [raft_id=3] [region_id=2] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [raft.rs:1175] ["became candidate at term 6"] [term=6] [raft_id=3] [region_id=2] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [raft.rs:1259] ["became leader at term 6"] [term=6] [raft_id=3] [region_id=2] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [store.rs:1380] ["start store"] [takes=213.076µs] [merge_count=0] [applying_count=0] [tombstone_count=0] [region_count=1] [store_id=1] [thread_id=1]
[2024/05/19 13:05:18.911 +08:00] [INFO] [store.rs:1436] ["cleans up garbage data"] [takes=7.35µs] [garbage_range_count=2] [store_id=1] [thread_id=1]
[2024/05/19 13:05:18.912 +08:00] [INFO] [peer.rs:5712] ["require updating max ts"] [initial_status=25769803778] [region_id=2] [thread_id=101]
[2024/05/19 13:05:18.913 +08:00] [WARN] [store.rs:1905] ["set thread priority for raftstore failed"] [error="Os { code: 13, kind: PermissionDenied, message: \"Permission denied\" }"] [thread_id=1]
[2024/05/19 13:05:18.913 +08:00] [INFO] [gc_worker.rs:1248] ["initialize compaction filter to perform GC when necessary"] [thread_id=1]
[2024/05/19 13:05:18.913 +08:00] [INFO] [compaction_filter.rs:182] ["initialize GC context for compaction filter"] [thread_id=1]
[2024/05/19 13:05:18.913 +08:00] [INFO] [pd.rs:1705] ["succeed to update max timestamp"] [region_id=2] [thread_id=31]
[2024/05/19 13:05:18.915 +08:00] [INFO] [endpoint.rs:701] ["register observe region"] [region="id: 2 region_epoch { conf_ver: 1 version: 1 } peers { id: 3 store_id: 1 }"] [thread_id=68]
[2024/05/19 13:05:18.916 +08:00] [INFO] [endpoint.rs:358] ["Resolver initialized"] [pending_data_index=0] [snapshot_index=6] [observe_id=ObserveId(0)] [region=2] [thread_id=68]
[2024/05/19 13:05:18.917 +08:00] [INFO] [server.rs:1206] ["start register debug service"] [thread_id=1]
[2024/05/19 13:05:18.917 +08:00] [INFO] [future.rs:148] ["starting working thread"] [worker=waiter-manager] [thread_id=1]
[2024/05/19 13:05:18.917 +08:00] [INFO] [future.rs:148] ["starting working thread"] [worker=deadlock-detector] [thread_id=1]
[2024/05/19 13:05:18.918 +08:00] [INFO] [deadlock.rs:761] ["became the leader of deadlock detector!"] [self_id=1] [thread_id=127]
[2024/05/19 13:05:18.918 +08:00] [INFO] [server.rs:1532] ["cpu quota set to 8.0"] [thread_id=17]
[2024/05/19 13:05:18.919 +08:00] [INFO] [server.rs:308] ["listening on addr"] [addr=0.0.0.0:20180] [thread_id=1]
[2024/05/19 13:05:18.919 +08:00] [INFO] [server.rs:1538] ["memory limit set to 34359738368"] [thread_id=17]
[2024/05/19 13:05:18.923 +08:00] [INFO] [server.rs:388] ["TiKV is ready to serve"] [thread_id=1]
[2024/05/19 13:05:18.923 +08:00] [ERROR] [server.rs:1578] ["failed to bind addr for status service"] [err_code=KV:Unknown] [err="Http(hyper::Error(Listen, Os { code: 98, kind: AddrInUse, message: \"Address already in use\" }))"] [thread_id=1]
[2024/05/19 13:05:21.930 +08:00] [INFO] [pd.rs:1531] ["try to split"] [region_epoch="conf_ver: 1 version: 1"] [region_id=2] [thread_id=31]
[2024/05/19 13:05:21.930 +08:00] [INFO] [peer.rs:6130] ["on split"] [source=pd] [split_keys="4 keys range from 7200000000000000FB to 7800000100000000FB"] [peer_id=3] [region_id=2] [thread_id=101]
[2024/05/19 13:05:21.930 +08:00] [INFO] [pd.rs:1031] ["try to batch split region"] [task=batch_split] [region="id: 2 region_epoch { conf_ver: 1 version: 1 } peers { id: 3 store_id: 1 }"] [new_region_ids="[new_region_id: 4 new_peer_ids: 5, new_region_id: 6 new_peer_ids: 7, new_region_id: 8 new_peer_ids: 9, new_region_id: 10 new_peer_ids: 11]"] [region_id=2] [thread_id=31]
[2024/05/19 13:05:21.931 +08:00] [INFO] [apply.rs:1712] ["execute admin command"] [command="cmd_type: BatchSplit splits { requests { split_key: 7200000000000000FB new_region_id: 4 new_peer_ids: 5 } requests { split_key: 7200000100000000FB new_region_id: 6 new_peer_ids: 7 } requests { split_key: 7800000000000000FB new_region_id: 8 new_peer_ids: 9 } requests { split_key: 7800000100000000FB new_region_id: 10 new_peer_ids: 11 } right_derive: true }"] [index=7] [term=6] [peer_id=3] [region_id=2] [thread_id=103]
[2024/05/19 13:05:21.931 +08:00] [INFO] [apply.rs:2578] ["split region"] [keys="4 keys range from 7200000000000000FB to 7800000100000000FB"] [region="id: 2 region_epoch { conf_ver: 1 version: 1 } peers { id: 3 store_id: 1 }"] [peer_id=3] [region_id=2] [thread_id=103]
[2024/05/19 13:05:21.931 +08:00] [INFO] [peer.rs:4250] ["moving 0 locks to new regions"] [region_id=2] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [endpoint.rs:279] ["region met split/merge command, stop tracking since key range changed, wait for re-register"] [req_type=BatchSplit] [thread_id=68]
[2024/05/19 13:05:21.931 +08:00] [INFO] [peer.rs:4296] ["notify pd with split"] [split_count=5] [peer_id=3] [region_id=2] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [endpoint.rs:748] ["deregister observe region"] [observe_id=ObserveId(0)] [region_id=2] [store_id=Some(1)] [thread_id=68]
[2024/05/19 13:05:21.931 +08:00] [INFO] [peer.rs:4378] ["insert new region"] [store_id=1] [is_uninitialized_peer_exist=false] [region="id: 4 end_key: 7200000000000000FB region_epoch { conf_ver: 1 version: 5 } peers { id: 5 store_id: 1 }"] [region_id=4] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [peer.rs:275] ["create peer"] [peer_id=5] [region_id=4] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [endpoint.rs:701] ["register observe region"] [region="id: 2 start_key: 7800000100000000FB region_epoch { conf_ver: 1 version: 5 } peers { id: 3 store_id: 1 }"] [thread_id=68]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:2684] ["switched to configuration"] [config="Configuration { voters: Configuration { incoming: Configuration { voters: {5} }, outgoing: Configuration { voters: {} } }, learners: {}, learners_next: {}, auto_leave: false }"] [raft_id=5] [region_id=4] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1151] ["became follower at term 5"] [term=5] [raft_id=5] [region_id=4] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:387] [newRaft] [peers="Configuration { incoming: Configuration { voters: {5} }, outgoing: Configuration { voters: {} } }"] ["last term"=5] ["last index"=5] [applied=5] [commit=5] [term=5] [raft_id=5] [region_id=4] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raw_node.rs:315] ["RawNode created with id 5."] [id=5] [raft_id=5] [region_id=4] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1556] ["starting a new election"] [term=5] [raft_id=5] [region_id=4] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1201] ["became pre-candidate at term 5"] [term=5] [raft_id=5] [region_id=4] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1175] ["became candidate at term 6"] [term=6] [raft_id=5] [region_id=4] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1259] ["became leader at term 6"] [term=6] [raft_id=5] [region_id=4] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [peer.rs:4378] ["insert new region"] [store_id=1] [is_uninitialized_peer_exist=false] [region="id: 6 start_key: 7200000000000000FB end_key: 7200000100000000FB region_epoch { conf_ver: 1 version: 5 } peers { id: 7 store_id: 1 }"] [region_id=6] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [peer.rs:275] ["create peer"] [peer_id=7] [region_id=6] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:2684] ["switched to configuration"] [config="Configuration { voters: Configuration { incoming: Configuration { voters: {7} }, outgoing: Configuration { voters: {} } }, learners: {}, learners_next: {}, auto_leave: false }"] [raft_id=7] [region_id=6] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1151] ["became follower at term 5"] [term=5] [raft_id=7] [region_id=6] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:387] [newRaft] [peers="Configuration { incoming: Configuration { voters: {7} }, outgoing: Configuration { voters: {} } }"] ["last term"=5] ["last index"=5] [applied=5] [commit=5] [term=5] [raft_id=7] [region_id=6] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raw_node.rs:315] ["RawNode created with id 7."] [id=7] [raft_id=7] [region_id=6] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1556] ["starting a new election"] [term=5] [raft_id=7] [region_id=6] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1201] ["became pre-candidate at term 5"] [term=5] [raft_id=7] [region_id=6] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1175] ["became candidate at term 6"] [term=6] [raft_id=7] [region_id=6] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1259] ["became leader at term 6"] [term=6] [raft_id=7] [region_id=6] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [peer.rs:4378] ["insert new region"] [store_id=1] [is_uninitialized_peer_exist=false] [region="id: 8 start_key: 7200000100000000FB end_key: 7800000000000000FB region_epoch { conf_ver: 1 version: 5 } peers { id: 9 store_id: 1 }"] [region_id=8] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [peer.rs:275] ["create peer"] [peer_id=9] [region_id=8] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:2684] ["switched to configuration"] [config="Configuration { voters: Configuration { incoming: Configuration { voters: {9} }, outgoing: Configuration { voters: {} } }, learners: {}, learners_next: {}, auto_leave: false }"] [raft_id=9] [region_id=8] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1151] ["became follower at term 5"] [term=5] [raft_id=9] [region_id=8] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:387] [newRaft] [peers="Configuration { incoming: Configuration { voters: {9} }, outgoing: Configuration { voters: {} } }"] ["last term"=5] ["last index"=5] [applied=5] [commit=5] [term=5] [raft_id=9] [region_id=8] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raw_node.rs:315] ["RawNode created with id 9."] [id=9] [raft_id=9] [region_id=8] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1556] ["starting a new election"] [term=5] [raft_id=9] [region_id=8] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1201] ["became pre-candidate at term 5"] [term=5] [raft_id=9] [region_id=8] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1175] ["became candidate at term 6"] [term=6] [raft_id=9] [region_id=8] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [raft.rs:1259] ["became leader at term 6"] [term=6] [raft_id=9] [region_id=8] [thread_id=101]
[2024/05/19 13:05:21.931 +08:00] [INFO] [peer.rs:4378] ["insert new region"] [store_id=1] [is_uninitialized_peer_exist=false] [region="id: 10 start_key: 7800000000000000FB end_key: 7800000100000000FB region_epoch { conf_ver: 1 version: 5 } peers { id: 11 store_id: 1 }"] [region_id=10] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [peer.rs:275] ["create peer"] [peer_id=11] [region_id=10] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [raft.rs:2684] ["switched to configuration"] [config="Configuration { voters: Configuration { incoming: Configuration { voters: {11} }, outgoing: Configuration { voters: {} } }, learners: {}, learners_next: {}, auto_leave: false }"] [raft_id=11] [region_id=10] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [raft.rs:1151] ["became follower at term 5"] [term=5] [raft_id=11] [region_id=10] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [raft.rs:387] [newRaft] [peers="Configuration { incoming: Configuration { voters: {11} }, outgoing: Configuration { voters: {} } }"] ["last term"=5] ["last index"=5] [applied=5] [commit=5] [term=5] [raft_id=11] [region_id=10] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [raw_node.rs:315] ["RawNode created with id 11."] [id=11] [raft_id=11] [region_id=10] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [raft.rs:1556] ["starting a new election"] [term=5] [raft_id=11] [region_id=10] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [raft.rs:1201] ["became pre-candidate at term 5"] [term=5] [raft_id=11] [region_id=10] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [raft.rs:1175] ["became candidate at term 6"] [term=6] [raft_id=11] [region_id=10] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [raft.rs:1259] ["became leader at term 6"] [term=6] [raft_id=11] [region_id=10] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [peer.rs:5712] ["require updating max ts"] [initial_status=25769803786] [region_id=4] [thread_id=102]
[2024/05/19 13:05:21.932 +08:00] [INFO] [peer.rs:5712] ["require updating max ts"] [initial_status=25769803786] [region_id=6] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [peer.rs:5712] ["require updating max ts"] [initial_status=25769803786] [region_id=8] [thread_id=101]
[2024/05/19 13:05:21.932 +08:00] [INFO] [peer.rs:5712] ["require updating max ts"] [initial_status=25769803786] [region_id=10] [thread_id=102]
[2024/05/19 13:05:21.932 +08:00] [INFO] [endpoint.rs:701] ["register observe region"] [region="id: 4 end_key: 7200000000000000FB region_epoch { conf_ver: 1 version: 5 } peers { id: 5 store_id: 1 }"] [thread_id=68]
[2024/05/19 13:05:21.932 +08:00] [INFO] [endpoint.rs:701] ["register observe region"] [region="id: 6 start_key: 7200000000000000FB end_key: 7200000100000000FB region_epoch { conf_ver: 1 version: 5 } peers { id: 7 store_id: 1 }"] [thread_id=68]
[2024/05/19 13:05:21.932 +08:00] [INFO] [endpoint.rs:701] ["register observe region"] [region="id: 10 start_key: 7800000000000000FB end_key: 7800000100000000FB region_epoch { conf_ver: 1 version: 5 } peers { id: 11 store_id: 1 }"] [thread_id=68]
[2024/05/19 13:05:21.932 +08:00] [INFO] [pd.rs:1705] ["succeed to update max timestamp"] [region_id=4] [thread_id=31]
[2024/05/19 13:05:21.932 +08:00] [INFO] [pd.rs:1705] ["succeed to update max timestamp"] [region_id=6] [thread_id=31]
[2024/05/19 13:05:21.932 +08:00] [INFO] [endpoint.rs:358] ["Resolver initialized"] [pending_data_index=0] [snapshot_index=7] [observe_id=ObserveId(1)] [region=2] [thread_id=68]
[2024/05/19 13:05:21.932 +08:00] [INFO] [endpoint.rs:701] ["register observe region"] [region="id: 8 start_key: 7200000100000000FB end_key: 7800000000000000FB region_epoch { conf_ver: 1 version: 5 } peers { id: 9 store_id: 1 }"] [thread_id=68]
[2024/05/19 13:05:21.932 +08:00] [INFO] [endpoint.rs:358] ["Resolver initialized"] [pending_data_index=0] [snapshot_index=6] [observe_id=ObserveId(2)] [region=4] [thread_id=68]
[2024/05/19 13:05:21.932 +08:00] [INFO] [pd.rs:1705] ["succeed to update max timestamp"] [region_id=8] [thread_id=31]
[2024/05/19 13:05:21.932 +08:00] [INFO] [pd.rs:1705] ["succeed to update max timestamp"] [region_id=10] [thread_id=31]
[2024/05/19 13:05:21.932 +08:00] [INFO] [endpoint.rs:358] ["Resolver initialized"] [pending_data_index=0] [snapshot_index=6] [observe_id=ObserveId(3)] [region=6] [thread_id=68]
[2024/05/19 13:05:21.932 +08:00] [INFO] [endpoint.rs:358] ["Resolver initialized"] [pending_data_index=0] [snapshot_index=6] [observe_id=ObserveId(4)] [region=10] [thread_id=68]
[2024/05/19 13:05:21.932 +08:00] [INFO] [endpoint.rs:358] ["Resolver initialized"] [pending_data_index=0] [snapshot_index=6] [observe_id=ObserveId(5)] [region=8] [thread_id=68]
[2024/05/19 13:05:28.914 +08:00] [INFO] [client.rs:799] ["set cluster version to 8.2.0-alpha"] [thread_id=31]
[2024/05/19 13:15:18.786 +08:00] [INFO] [util.rs:639] ["connecting to PD endpoint"] [endpoints=http://127.0.0.1:2399] [thread_id=12]
[2024/05/19 13:25:18.787 +08:00] [INFO] [util.rs:639] ["connecting to PD endpoint"] [endpoints=http://127.0.0.1:2399] [thread_id=12]