{"level":"warn","ts":"2026-10-15T06:33:56.92987Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T06:33:56.929979Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.195:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.195:2380","--initial-cluster=instance=https://199.19.213.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.195:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-15T06:33:56.930069Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T06:33:56.930076Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.195:2380"]} {"level":"info","ts":"2026-10-15T06:33:56.930095Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-15T06:33:56.930803Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.195:2379"]} {"level":"info","ts":"2026-10-15T06:33:56.930994Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.195:2380"],"listen-peer-urls":["https://199.19.213.195:2380"],"advertise-client-urls":["https://199.19.213.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.195:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-15T06:33:56.93733Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.084027ms"} {"level":"info","ts":"2026-10-15T06:33:56.953559Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2808ca5e53a916c4","cluster-id":"b7ef986abcd4d0b8"} {"level":"info","ts":"2026-10-15T06:33:56.95369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T06:33:56.953713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 became follower at term 0"} {"level":"info","ts":"2026-10-15T06:33:56.953724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2808ca5e53a916c4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T06:33:56.953735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 became follower at term 1"} {"level":"info","ts":"2026-10-15T06:33:56.95383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 switched to configuration voters=(2884778067810129604)"} {"level":"warn","ts":"2026-10-15T06:33:56.968444Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T06:33:56.970873Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T06:33:56.972673Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-15T06:33:56.975597Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2808ca5e53a916c4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T06:33:56.975712Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-15T06:33:56.975812Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-15T06:33:56.975821Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-15T06:33:56.977048Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2808ca5e53a916c4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T06:33:56.977396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 switched to configuration voters=(2884778067810129604)"} {"level":"info","ts":"2026-10-15T06:33:56.977475Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b7ef986abcd4d0b8","local-member-id":"2808ca5e53a916c4","added-peer-id":"2808ca5e53a916c4","added-peer-peer-urls":["https://199.19.213.195:2380"]} {"level":"info","ts":"2026-10-15T06:33:56.980065Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-15T06:33:56.980315Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2808ca5e53a916c4","initial-advertise-peer-urls":["https://199.19.213.195:2380"],"listen-peer-urls":["https://199.19.213.195:2380"],"advertise-client-urls":["https://199.19.213.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T06:33:56.980352Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T06:33:56.980903Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.195:2380"} {"level":"info","ts":"2026-10-15T06:33:56.980935Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.195:2380"} {"level":"info","ts":"2026-10-15T06:33:57.854378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T06:33:57.854458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T06:33:57.85451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 received MsgPreVoteResp from 2808ca5e53a916c4 at term 1"} {"level":"info","ts":"2026-10-15T06:33:57.854535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 became candidate at term 2"} {"level":"info","ts":"2026-10-15T06:33:57.854546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 received MsgVoteResp from 2808ca5e53a916c4 at term 2"} {"level":"info","ts":"2026-10-15T06:33:57.854586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2808ca5e53a916c4 became leader at term 2"} {"level":"info","ts":"2026-10-15T06:33:57.854611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2808ca5e53a916c4 elected leader 2808ca5e53a916c4 at term 2"} {"level":"info","ts":"2026-10-15T06:33:57.856557Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:33:57.861638Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2808ca5e53a916c4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.195:2379]}","request-path":"/0/members/2808ca5e53a916c4/attributes","cluster-id":"b7ef986abcd4d0b8","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T06:33:57.861639Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:33:57.861695Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:33:57.861955Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T06:33:57.862019Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T06:33:57.864018Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.195:2379"} {"level":"info","ts":"2026-10-15T06:33:57.865205Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T06:33:57.875555Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b7ef986abcd4d0b8","local-member-id":"2808ca5e53a916c4","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:33:57.875722Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:33:57.875777Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-10-15T06:34:02.660181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.809119ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:34:02.660655Z","caller":"traceutil/trace.go:171","msg":"trace[1602813634] linearizableReadLoop","detail":"{readStateIndex:210; appliedIndex:209; }","duration":"369.690864ms","start":"2026-10-15T06:34:02.290941Z","end":"2026-10-15T06:34:02.660632Z","steps":["trace[1602813634] 'read index received' (duration: 111.761029ms)","trace[1602813634] 'applied index is now lower than readState.Index' (duration: 257.926205ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:34:02.660782Z","caller":"traceutil/trace.go:171","msg":"trace[1664430945] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"459.782585ms","start":"2026-10-15T06:34:02.200891Z","end":"2026-10-15T06:34:02.660673Z","steps":["trace[1664430945] 'process raft request' (duration: 201.800579ms)","trace[1664430945] 'compare' (duration: 256.668247ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:34:02.660892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.934949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3492"} {"level":"warn","ts":"2026-10-15T06:34:02.660948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.087223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T06:34:02.660999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:34:02.200811Z","time spent":"460.073061ms","remote":"127.0.0.1:41710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:34:02.660987Z","caller":"traceutil/trace.go:171","msg":"trace[299567708] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:205; }","duration":"370.103763ms","start":"2026-10-15T06:34:02.290856Z","end":"2026-10-15T06:34:02.66096Z","steps":["trace[299567708] 'agreement among raft nodes before linearized reading' (duration: 369.928379ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:34:02.661045Z","caller":"traceutil/trace.go:171","msg":"trace[278056824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:205; }","duration":"276.215617ms","start":"2026-10-15T06:34:02.384818Z","end":"2026-10-15T06:34:02.661033Z","steps":["trace[278056824] 'agreement among raft nodes before linearized reading' (duration: 276.036923ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:34:02.66114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:34:02.290834Z","time spent":"370.296927ms","remote":"127.0.0.1:41626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3515,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-10-15T06:34:02.888962Z","caller":"traceutil/trace.go:171","msg":"trace[212872162] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"220.993472ms","start":"2026-10-15T06:34:02.667943Z","end":"2026-10-15T06:34:02.888936Z","steps":["trace[212872162] 'process raft request' (duration: 183.109057ms)","trace[212872162] 'compare' (duration: 37.727571ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:34:03.281107Z","caller":"traceutil/trace.go:171","msg":"trace[339978728] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"612.641351ms","start":"2026-10-15T06:34:02.668423Z","end":"2026-10-15T06:34:03.281064Z","steps":["trace[339978728] 'process raft request' (duration: 601.064419ms)","trace[339978728] 'compare' (duration: 10.894336ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:34:03.281216Z","caller":"traceutil/trace.go:171","msg":"trace[1588852476] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"329.332345ms","start":"2026-10-15T06:34:02.951851Z","end":"2026-10-15T06:34:03.281184Z","steps":["trace[1588852476] 'process raft request' (duration: 328.956696ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:34:03.281292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:34:02.6684Z","time spent":"612.793974ms","remote":"127.0.0.1:41626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:34:03.281348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:34:02.951827Z","time spent":"329.451287ms","remote":"127.0.0.1:41630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T06:34:03.281447Z","caller":"traceutil/trace.go:171","msg":"trace[171353441] linearizableReadLoop","detail":"{readStateIndex:212; appliedIndex:211; }","duration":"388.605391ms","start":"2026-10-15T06:34:02.892805Z","end":"2026-10-15T06:34:03.28141Z","steps":["trace[171353441] 'read index received' (duration: 376.65769ms)","trace[171353441] 'applied index is now lower than readState.Index' (duration: 11.94336ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:34:03.281428Z","caller":"traceutil/trace.go:171","msg":"trace[835414164] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"294.632031ms","start":"2026-10-15T06:34:02.986759Z","end":"2026-10-15T06:34:03.281391Z","steps":["trace[835414164] 'process raft request' (duration: 294.12546ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:34:03.281704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.825015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-15T06:34:03.281763Z","caller":"traceutil/trace.go:171","msg":"trace[618404710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:210; }","duration":"388.966838ms","start":"2026-10-15T06:34:02.89277Z","end":"2026-10-15T06:34:03.281736Z","steps":["trace[618404710] 'agreement among raft nodes before linearized reading' (duration: 388.747193ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:34:03.281818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:34:02.892755Z","time spent":"389.05431ms","remote":"127.0.0.1:41710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-15T06:34:50.798616Z","caller":"traceutil/trace.go:171","msg":"trace[923198380] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"115.050571ms","start":"2026-10-15T06:34:50.683546Z","end":"2026-10-15T06:34:50.798596Z","steps":["trace[923198380] 'process raft request' (duration: 114.361006ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:34:50.799099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.413371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-10-15T06:34:50.799195Z","caller":"traceutil/trace.go:171","msg":"trace[1405692825] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:620; }","duration":"109.575745ms","start":"2026-10-15T06:34:50.689603Z","end":"2026-10-15T06:34:50.799179Z","steps":["trace[1405692825] 'agreement among raft nodes before linearized reading' (duration: 109.235488ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:34:50.799568Z","caller":"traceutil/trace.go:171","msg":"trace[236803770] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:650; }","duration":"109.145986ms","start":"2026-10-15T06:34:50.689637Z","end":"2026-10-15T06:34:50.798783Z","steps":["trace[236803770] 'read index received' (duration: 109.040403ms)","trace[236803770] 'applied index is now lower than readState.Index' (duration: 24.061µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:34:53.036762Z","caller":"traceutil/trace.go:171","msg":"trace[1851143564] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"161.878809ms","start":"2026-10-15T06:34:52.874852Z","end":"2026-10-15T06:34:53.036731Z","steps":["trace[1851143564] 'process raft request' (duration: 154.275666ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:34:59.591108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.593384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-15T06:34:59.591263Z","caller":"traceutil/trace.go:171","msg":"trace[1619037621] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:690; }","duration":"177.812079ms","start":"2026-10-15T06:34:59.413415Z","end":"2026-10-15T06:34:59.591227Z","steps":["trace[1619037621] 'range keys from in-memory index tree' (duration: 177.280467ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:34:59.82406Z","caller":"traceutil/trace.go:171","msg":"trace[1042553794] linearizableReadLoop","detail":"{readStateIndex:723; appliedIndex:722; }","duration":"106.573971ms","start":"2026-10-15T06:34:59.717442Z","end":"2026-10-15T06:34:59.824016Z","steps":["trace[1042553794] 'read index received' (duration: 105.955797ms)","trace[1042553794] 'applied index is now lower than readState.Index' (duration: 616.594µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:34:59.824241Z","caller":"traceutil/trace.go:171","msg":"trace[1482633075] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"226.584007ms","start":"2026-10-15T06:34:59.597638Z","end":"2026-10-15T06:34:59.824222Z","steps":["trace[1482633075] 'process raft request' (duration: 225.990275ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:34:59.82443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.018459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-15T06:34:59.824558Z","caller":"traceutil/trace.go:171","msg":"trace[81026800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:691; }","duration":"106.196663ms","start":"2026-10-15T06:34:59.718339Z","end":"2026-10-15T06:34:59.824536Z","steps":["trace[81026800] 'agreement among raft nodes before linearized reading' (duration: 105.963308ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:34:59.824693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.206394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:34:59.824749Z","caller":"traceutil/trace.go:171","msg":"trace[1501436630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:691; }","duration":"107.342607ms","start":"2026-10-15T06:34:59.717389Z","end":"2026-10-15T06:34:59.824732Z","steps":["trace[1501436630] 'agreement among raft nodes before linearized reading' (duration: 107.066591ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:17.613226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.410025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-15T06:35:17.613387Z","caller":"traceutil/trace.go:171","msg":"trace[1659479358] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:811; }","duration":"334.62511ms","start":"2026-10-15T06:35:17.278711Z","end":"2026-10-15T06:35:17.613336Z","steps":["trace[1659479358] 'range keys from in-memory index tree' (duration: 334.070998ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:17.613485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:35:17.278682Z","time spent":"334.784474ms","remote":"127.0.0.1:41710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-15T06:35:59.077496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.130545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T06:35:59.077647Z","caller":"traceutil/trace.go:171","msg":"trace[353780256] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1098; }","duration":"538.37244ms","start":"2026-10-15T06:35:58.539242Z","end":"2026-10-15T06:35:59.077614Z","steps":["trace[353780256] 'count revisions from in-memory index tree' (duration: 537.919031ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:59.077711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:35:58.539212Z","time spent":"538.480792ms","remote":"127.0.0.1:41876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":30,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-10-15T06:35:59.077803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.4635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-10-15T06:35:59.077804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.866241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-15T06:35:59.077891Z","caller":"traceutil/trace.go:171","msg":"trace[1828908895] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1098; }","duration":"278.609093ms","start":"2026-10-15T06:35:58.799258Z","end":"2026-10-15T06:35:59.077867Z","steps":["trace[1828908895] 'range keys from in-memory index tree' (duration: 278.252146ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:59.077914Z","caller":"traceutil/trace.go:171","msg":"trace[588593639] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1098; }","duration":"145.029384ms","start":"2026-10-15T06:35:58.932848Z","end":"2026-10-15T06:35:59.077878Z","steps":["trace[588593639] 'range keys from in-memory index tree' (duration: 144.640976ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:36:18.449073Z","caller":"traceutil/trace.go:171","msg":"trace[452369560] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"129.554012ms","start":"2026-10-15T06:36:18.319458Z","end":"2026-10-15T06:36:18.449012Z","steps":["trace[452369560] 'process raft request' (duration: 129.308447ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:36:18.713652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.385799ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:36:18.713769Z","caller":"traceutil/trace.go:171","msg":"trace[147890213] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"260.767469ms","start":"2026-10-15T06:36:18.452982Z","end":"2026-10-15T06:36:18.71375Z","steps":["trace[147890213] 'process raft request' (duration: 150.033913ms)","trace[147890213] 'compare' (duration: 110.176785ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:36:19.461307Z","caller":"traceutil/trace.go:171","msg":"trace[1446843325] linearizableReadLoop","detail":"{readStateIndex:1240; appliedIndex:1239; }","duration":"158.741021ms","start":"2026-10-15T06:36:19.302522Z","end":"2026-10-15T06:36:19.461263Z","steps":["trace[1446843325] 'read index received' (duration: 146.556768ms)","trace[1446843325] 'applied index is now lower than readState.Index' (duration: 12.181623ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:36:19.461553Z","caller":"traceutil/trace.go:171","msg":"trace[1521050399] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"161.147453ms","start":"2026-10-15T06:36:19.30038Z","end":"2026-10-15T06:36:19.461527Z","steps":["trace[1521050399] 'process raft request' (duration: 148.761395ms)","trace[1521050399] 'compare' (duration: 11.925168ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:36:19.461839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.162395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-15T06:36:19.461943Z","caller":"traceutil/trace.go:171","msg":"trace[1617217754] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1187; }","duration":"130.340659ms","start":"2026-10-15T06:36:19.331577Z","end":"2026-10-15T06:36:19.461917Z","steps":["trace[1617217754] 'agreement among raft nodes before linearized reading' (duration: 130.085983ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:36:19.462078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.557768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:36:19.46211Z","caller":"traceutil/trace.go:171","msg":"trace[115509578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1187; }","duration":"159.63861ms","start":"2026-10-15T06:36:19.302456Z","end":"2026-10-15T06:36:19.462095Z","steps":["trace[115509578] 'agreement among raft nodes before linearized reading' (duration: 159.599649ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:36:20.317879Z","caller":"traceutil/trace.go:171","msg":"trace[824046115] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"238.025749ms","start":"2026-10-15T06:36:20.079819Z","end":"2026-10-15T06:36:20.317845Z","steps":["trace[824046115] 'process raft request' (duration: 237.812734ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:36:35.207278Z","caller":"traceutil/trace.go:171","msg":"trace[478243783] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"107.805783ms","start":"2026-10-15T06:36:35.099438Z","end":"2026-10-15T06:36:35.207244Z","steps":["trace[478243783] 'process raft request' (duration: 107.590258ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:36:35.679217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.094963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-10-15T06:36:35.679476Z","caller":"traceutil/trace.go:171","msg":"trace[2095732750] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1289; }","duration":"413.381629ms","start":"2026-10-15T06:36:35.266019Z","end":"2026-10-15T06:36:35.6794Z","steps":["trace[2095732750] 'range keys from in-memory index tree' (duration: 412.795065ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:36:35.679607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:36:35.265986Z","time spent":"413.572162ms","remote":"127.0.0.1:41710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":547,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-10-15T06:36:35.720288Z","caller":"traceutil/trace.go:171","msg":"trace[318462700] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1345; }","duration":"227.454644ms","start":"2026-10-15T06:36:35.4928Z","end":"2026-10-15T06:36:35.720255Z","steps":["trace[318462700] 'read index received' (duration: 227.388473ms)","trace[318462700] 'applied index is now lower than readState.Index' (duration: 65.131µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:36:35.720557Z","caller":"traceutil/trace.go:171","msg":"trace[1725801782] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"365.378287ms","start":"2026-10-15T06:36:35.355142Z","end":"2026-10-15T06:36:35.72052Z","steps":["trace[1725801782] 'process raft request' (duration: 364.912177ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:36:35.720839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:36:35.355113Z","time spent":"365.528111ms","remote":"127.0.0.1:41710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:36:35.721172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.377504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-10-15T06:36:35.721506Z","caller":"traceutil/trace.go:171","msg":"trace[381348577] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1290; }","duration":"228.764522ms","start":"2026-10-15T06:36:35.492724Z","end":"2026-10-15T06:36:35.721488Z","steps":["trace[381348577] 'agreement among raft nodes before linearized reading' (duration: 228.019026ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:36:35.723978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.88168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-15T06:36:35.724145Z","caller":"traceutil/trace.go:171","msg":"trace[1515632276] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1291; }","duration":"141.123696ms","start":"2026-10-15T06:36:35.582989Z","end":"2026-10-15T06:36:35.724113Z","steps":["trace[1515632276] 'agreement among raft nodes before linearized reading' (duration: 140.713557ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:36:35.72481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.352982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-15T06:36:35.725542Z","caller":"traceutil/trace.go:171","msg":"trace[420503096] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1291; }","duration":"164.136788ms","start":"2026-10-15T06:36:35.561369Z","end":"2026-10-15T06:36:35.725506Z","steps":["trace[420503096] 'agreement among raft nodes before linearized reading' (duration: 162.131515ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:41:23.894479Z","caller":"traceutil/trace.go:171","msg":"trace[1699329623] linearizableReadLoop","detail":"{readStateIndex:2755; appliedIndex:2754; }","duration":"385.522831ms","start":"2026-10-15T06:41:23.508929Z","end":"2026-10-15T06:41:23.894452Z","steps":["trace[1699329623] 'read index received' (duration: 385.259485ms)","trace[1699329623] 'applied index is now lower than readState.Index' (duration: 262.256µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:41:23.894561Z","caller":"traceutil/trace.go:171","msg":"trace[1421904104] transaction","detail":"{read_only:false; response_revision:2640; number_of_response:1; }","duration":"397.064685ms","start":"2026-10-15T06:41:23.497461Z","end":"2026-10-15T06:41:23.894526Z","steps":["trace[1421904104] 'process raft request' (duration: 396.82381ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:41:23.89472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.781226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-15T06:41:23.894754Z","caller":"traceutil/trace.go:171","msg":"trace[874866375] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2640; }","duration":"385.859598ms","start":"2026-10-15T06:41:23.508884Z","end":"2026-10-15T06:41:23.894743Z","steps":["trace[874866375] 'agreement among raft nodes before linearized reading' (duration: 385.715205ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:41:23.89476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:41:23.497443Z","time spent":"397.201678ms","remote":"127.0.0.1:41710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:41:23.894775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.459549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"warn","ts":"2026-10-15T06:41:23.89479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.582533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T06:41:23.894798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:41:23.508858Z","time spent":"385.931789ms","remote":"127.0.0.1:41710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-15T06:41:23.894833Z","caller":"traceutil/trace.go:171","msg":"trace[997659600] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2640; }","duration":"382.575082ms","start":"2026-10-15T06:41:23.512243Z","end":"2026-10-15T06:41:23.894819Z","steps":["trace[997659600] 'agreement among raft nodes before linearized reading' (duration: 382.396978ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:41:23.894859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:41:23.512221Z","time spent":"382.633182ms","remote":"127.0.0.1:41710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-10-15T06:41:23.894866Z","caller":"traceutil/trace.go:171","msg":"trace[1588066057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2640; }","duration":"178.631974ms","start":"2026-10-15T06:41:23.716192Z","end":"2026-10-15T06:41:23.894824Z","steps":["trace[1588066057] 'agreement among raft nodes before linearized reading' (duration: 178.561952ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:41:23.894974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.320835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:41:23.895085Z","caller":"traceutil/trace.go:171","msg":"trace[1566462657] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2640; }","duration":"203.506849ms","start":"2026-10-15T06:41:23.691556Z","end":"2026-10-15T06:41:23.895063Z","steps":["trace[1566462657] 'agreement among raft nodes before linearized reading' (duration: 203.297054ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:41:24.044237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.255176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:41:24.044345Z","caller":"traceutil/trace.go:171","msg":"trace[518451617] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:2640; }","duration":"144.45905ms","start":"2026-10-15T06:41:23.899864Z","end":"2026-10-15T06:41:24.044323Z","steps":["trace[518451617] 'range keys from in-memory index tree' (duration: 144.123834ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:41:24.044764Z","caller":"traceutil/trace.go:171","msg":"trace[1495735521] transaction","detail":"{read_only:false; response_revision:2641; number_of_response:1; }","duration":"144.47061ms","start":"2026-10-15T06:41:23.900243Z","end":"2026-10-15T06:41:24.044713Z","steps":["trace[1495735521] 'process raft request' (duration: 111.028882ms)","trace[1495735521] 'compare' (duration: 33.069771ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:41:24.063569Z","caller":"traceutil/trace.go:171","msg":"trace[422593260] transaction","detail":"{read_only:false; response_revision:2642; number_of_response:1; }","duration":"162.576818ms","start":"2026-10-15T06:41:23.900966Z","end":"2026-10-15T06:41:24.063543Z","steps":["trace[422593260] 'process raft request' (duration: 162.414565ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:41:24.527747Z","caller":"traceutil/trace.go:171","msg":"trace[451169096] transaction","detail":"{read_only:false; response_revision:2645; number_of_response:1; }","duration":"103.00715ms","start":"2026-10-15T06:41:24.424714Z","end":"2026-10-15T06:41:24.527721Z","steps":["trace[451169096] 'process raft request' (duration: 93.796402ms)"],"step_count":1}