{"level":"warn","ts":"2026-09-19T01:53:23.560004Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T01:53:23.560132Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.217: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://162.253.55.217:2380","--initial-cluster=instance=https://162.253.55.217:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.217:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.217: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-09-19T01:53:23.560204Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T01:53:23.560229Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.217:2380"]} {"level":"info","ts":"2026-09-19T01:53:23.560257Z","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-09-19T01:53:23.56084Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"]} {"level":"info","ts":"2026-09-19T01:53:23.560944Z","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://162.253.55.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.217: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-09-19T01:53:23.565395Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.220731ms"} {"level":"info","ts":"2026-09-19T01:53:23.574239Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e368e6818bd6f7","cluster-id":"289e52865b7eaeb1"} {"level":"info","ts":"2026-09-19T01:53:23.574389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T01:53:23.574426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 0"} {"level":"info","ts":"2026-09-19T01:53:23.574447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e368e6818bd6f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T01:53:23.574463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 1"} {"level":"info","ts":"2026-09-19T01:53:23.574523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"warn","ts":"2026-09-19T01:53:23.585651Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T01:53:23.589292Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T01:53:23.591202Z","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-09-19T01:53:23.59517Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e368e6818bd6f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T01:53:23.595426Z","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-09-19T01:53:23.595568Z","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-09-19T01:53:23.595595Z","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-09-19T01:53:23.595483Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e368e6818bd6f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T01:53:23.596609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"info","ts":"2026-09-19T01:53:23.596915Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","added-peer-id":"f1e368e6818bd6f7","added-peer-peer-urls":["https://162.253.55.217:2380"]} {"level":"info","ts":"2026-09-19T01:53:23.599564Z","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-09-19T01:53:23.599817Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-09-19T01:53:23.599843Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-09-19T01:53:23.601386Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e368e6818bd6f7","initial-advertise-peer-urls":["https://162.253.55.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T01:53:23.601421Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T01:53:24.075112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T01:53:24.075174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T01:53:24.075204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgPreVoteResp from f1e368e6818bd6f7 at term 1"} {"level":"info","ts":"2026-09-19T01:53:24.075218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became candidate at term 2"} {"level":"info","ts":"2026-09-19T01:53:24.075236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgVoteResp from f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-09-19T01:53:24.075246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became leader at term 2"} {"level":"info","ts":"2026-09-19T01:53:24.075262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e368e6818bd6f7 elected leader f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-09-19T01:53:24.076171Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e368e6818bd6f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.217:2379]}","request-path":"/0/members/f1e368e6818bd6f7/attributes","cluster-id":"289e52865b7eaeb1","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T01:53:24.076202Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:53:24.076338Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:53:24.076445Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:53:24.076542Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T01:53:24.076722Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T01:53:24.077138Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:53:24.077211Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:53:24.077234Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:53:24.079073Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T01:53:24.080922Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.217:2379"} {"level":"info","ts":"2026-09-19T01:53:47.532241Z","caller":"traceutil/trace.go:171","msg":"trace[2099973757] linearizableReadLoop","detail":"{readStateIndex:475; appliedIndex:474; }","duration":"135.31009ms","start":"2026-09-19T01:53:47.39686Z","end":"2026-09-19T01:53:47.53217Z","steps":["trace[2099973757] 'read index received' (duration: 96.794658ms)","trace[2099973757] 'applied index is now lower than readState.Index' (duration: 38.514532ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:53:47.532256Z","caller":"traceutil/trace.go:171","msg":"trace[612486074] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"201.86221ms","start":"2026-09-19T01:53:47.330361Z","end":"2026-09-19T01:53:47.532223Z","steps":["trace[612486074] 'process raft request' (duration: 163.363207ms)","trace[612486074] 'compare' (duration: 38.299208ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:53:47.532394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.487414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.217\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-19T01:53:47.532731Z","caller":"traceutil/trace.go:171","msg":"trace[1042775565] range","detail":"{range_begin:/registry/masterleases/162.253.55.217; range_end:; response_count:1; response_revision:459; }","duration":"135.885594ms","start":"2026-09-19T01:53:47.396821Z","end":"2026-09-19T01:53:47.532706Z","steps":["trace[1042775565] 'agreement among raft nodes before linearized reading' (duration: 135.484804ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:54:07.044307Z","caller":"traceutil/trace.go:171","msg":"trace[211599963] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"176.769544ms","start":"2026-09-19T01:54:06.867502Z","end":"2026-09-19T01:54:07.044272Z","steps":["trace[211599963] 'read index received' (duration: 175.838196ms)","trace[211599963] 'applied index is now lower than readState.Index' (duration: 930.158µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:54:07.044386Z","caller":"traceutil/trace.go:171","msg":"trace[1650450727] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"287.297137ms","start":"2026-09-19T01:54:06.757062Z","end":"2026-09-19T01:54:07.044359Z","steps":["trace[1650450727] 'process raft request' (duration: 286.542152ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:07.044603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.076881ms","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-09-19T01:54:07.044657Z","caller":"traceutil/trace.go:171","msg":"trace[1392708265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"177.176873ms","start":"2026-09-19T01:54:06.867466Z","end":"2026-09-19T01:54:07.044643Z","steps":["trace[1392708265] 'agreement among raft nodes before linearized reading' (duration: 176.973259ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:07.43897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.092182ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:54:07.439071Z","caller":"traceutil/trace.go:171","msg":"trace[1794577863] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"388.697939ms","start":"2026-09-19T01:54:07.050356Z","end":"2026-09-19T01:54:07.439054Z","steps":["trace[1794577863] 'process raft request' (duration: 215.007935ms)","trace[1794577863] 'compare' (duration: 172.9928ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:54:07.439127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:07.050323Z","time spent":"388.77615ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:54:07.470646Z","caller":"traceutil/trace.go:171","msg":"trace[1335771096] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"294.469222ms","start":"2026-09-19T01:54:07.176154Z","end":"2026-09-19T01:54:07.470624Z","steps":["trace[1335771096] 'read index received' (duration: 89.223586ms)","trace[1335771096] 'applied index is now lower than readState.Index' (duration: 205.244576ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:54:07.470782Z","caller":"traceutil/trace.go:171","msg":"trace[1302391902] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"350.682215ms","start":"2026-09-19T01:54:07.120056Z","end":"2026-09-19T01:54:07.470739Z","steps":["trace[1302391902] 'process raft request' (duration: 350.44915ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:07.470959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:07.120037Z","time spent":"350.846679ms","remote":"127.0.0.1:42088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:54:07.470946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.763168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2g9r5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-19T01:54:07.471026Z","caller":"traceutil/trace.go:171","msg":"trace[417158394] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2g9r5; range_end:; response_count:1; response_revision:633; }","duration":"294.901871ms","start":"2026-09-19T01:54:07.176102Z","end":"2026-09-19T01:54:07.471004Z","steps":["trace[417158394] 'agreement among raft nodes before linearized reading' (duration: 294.642375ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:07.470823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.855201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:54:07.471108Z","caller":"traceutil/trace.go:171","msg":"trace[875227849] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"186.169819ms","start":"2026-09-19T01:54:07.284903Z","end":"2026-09-19T01:54:07.471073Z","steps":["trace[875227849] 'agreement among raft nodes before linearized reading' (duration: 185.843581ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:08.073073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.150061ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:54:08.07345Z","caller":"traceutil/trace.go:171","msg":"trace[779877780] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:633; }","duration":"195.354226ms","start":"2026-09-19T01:54:07.877886Z","end":"2026-09-19T01:54:08.073241Z","steps":["trace[779877780] 'range keys from in-memory index tree' (duration: 195.10821ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:08.073594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.325042ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-09-19T01:54:08.073824Z","caller":"traceutil/trace.go:171","msg":"trace[1141180227] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"583.940883ms","start":"2026-09-19T01:54:07.489866Z","end":"2026-09-19T01:54:08.073806Z","steps":["trace[1141180227] 'process raft request' (duration: 583.828011ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:08.073921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:07.489802Z","time spent":"584.059555ms","remote":"127.0.0.1:41910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:54:08.074062Z","caller":"traceutil/trace.go:171","msg":"trace[2000123760] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"592.266333ms","start":"2026-09-19T01:54:07.481763Z","end":"2026-09-19T01:54:08.07403Z","steps":["trace[2000123760] 'read index received' (duration: 318.553312ms)","trace[2000123760] 'applied index is now lower than readState.Index' (duration: 273.708991ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:54:08.074043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:07.472545Z","time spent":"601.49163ms","remote":"127.0.0.1:41744","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-09-19T01:54:08.074199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.436816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:54:08.074255Z","caller":"traceutil/trace.go:171","msg":"trace[1760919315] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:634; }","duration":"592.526378ms","start":"2026-09-19T01:54:07.481716Z","end":"2026-09-19T01:54:08.074242Z","steps":["trace[1760919315] 'agreement among raft nodes before linearized reading' (duration: 592.428086ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:08.07429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:07.481693Z","time spent":"592.587029ms","remote":"127.0.0.1:42248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"info","ts":"2026-09-19T01:54:25.3072Z","caller":"traceutil/trace.go:171","msg":"trace[274719340] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"101.427985ms","start":"2026-09-19T01:54:25.20575Z","end":"2026-09-19T01:54:25.307178Z","steps":["trace[274719340] 'process raft request' (duration: 100.807114ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:54:25.447491Z","caller":"traceutil/trace.go:171","msg":"trace[30576708] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"132.001666ms","start":"2026-09-19T01:54:25.315468Z","end":"2026-09-19T01:54:25.44747Z","steps":["trace[30576708] 'process raft request' (duration: 131.856983ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:54:56.010716Z","caller":"traceutil/trace.go:171","msg":"trace[839386212] linearizableReadLoop","detail":"{readStateIndex:1246; appliedIndex:1245; }","duration":"241.832604ms","start":"2026-09-19T01:54:55.768856Z","end":"2026-09-19T01:54:56.010689Z","steps":["trace[839386212] 'read index received' (duration: 241.602521ms)","trace[839386212] 'applied index is now lower than readState.Index' (duration: 228.973µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:54:56.01076Z","caller":"traceutil/trace.go:171","msg":"trace[1204284934] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"297.210005ms","start":"2026-09-19T01:54:55.713521Z","end":"2026-09-19T01:54:56.010731Z","steps":["trace[1204284934] 'process raft request' (duration: 297.012242ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:56.010946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.046888ms","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-09-19T01:54:56.010998Z","caller":"traceutil/trace.go:171","msg":"trace[746477578] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1210; }","duration":"242.152769ms","start":"2026-09-19T01:54:55.768829Z","end":"2026-09-19T01:54:56.010982Z","steps":["trace[746477578] 'agreement among raft nodes before linearized reading' (duration: 241.969866ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:44.288037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.253426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:55:44.288114Z","caller":"traceutil/trace.go:171","msg":"trace[973265641] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1873; }","duration":"280.373209ms","start":"2026-09-19T01:55:44.007723Z","end":"2026-09-19T01:55:44.288096Z","steps":["trace[973265641] 'count revisions from in-memory index tree' (duration: 280.210646ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:44.50957Z","caller":"traceutil/trace.go:171","msg":"trace[447118714] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"180.381045ms","start":"2026-09-19T01:55:44.329139Z","end":"2026-09-19T01:55:44.50952Z","steps":["trace[447118714] 'process raft request' (duration: 180.247203ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:44.702609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.667632ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:55:44.702754Z","caller":"traceutil/trace.go:171","msg":"trace[869155910] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1948; }","duration":"128.263833ms","start":"2026-09-19T01:55:44.574475Z","end":"2026-09-19T01:55:44.702739Z","steps":["trace[869155910] 'read index received' (duration: 27.306787ms)","trace[869155910] 'applied index is now lower than readState.Index' (duration: 100.955986ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:55:44.702832Z","caller":"traceutil/trace.go:171","msg":"trace[555877605] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"372.704145ms","start":"2026-09-19T01:55:44.3301Z","end":"2026-09-19T01:55:44.702804Z","steps":["trace[555877605] 'process raft request' (duration: 271.751009ms)","trace[555877605] 'compare' (duration: 100.572101ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:55:44.702841Z","caller":"traceutil/trace.go:171","msg":"trace[809297201] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"343.42834ms","start":"2026-09-19T01:55:44.359402Z","end":"2026-09-19T01:55:44.70283Z","steps":["trace[809297201] 'process raft request' (duration: 343.286828ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:44.702978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:55:44.329971Z","time spent":"372.929448ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:55:44.703255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.772912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-19T01:55:44.703326Z","caller":"traceutil/trace.go:171","msg":"trace[1880842671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1876; }","duration":"128.888063ms","start":"2026-09-19T01:55:44.57442Z","end":"2026-09-19T01:55:44.703308Z","steps":["trace[1880842671] 'agreement among raft nodes before linearized reading' (duration: 128.550097ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:44.703889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:55:44.359385Z","time spent":"343.553112ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:55:44.984437Z","caller":"traceutil/trace.go:171","msg":"trace[292516770] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"276.221251ms","start":"2026-09-19T01:55:44.70819Z","end":"2026-09-19T01:55:44.984412Z","steps":["trace[292516770] 'process raft request' (duration: 200.069598ms)","trace[292516770] 'compare' (duration: 75.92842ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:55:45.040483Z","caller":"traceutil/trace.go:171","msg":"trace[1745331353] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"330.946116ms","start":"2026-09-19T01:55:44.70951Z","end":"2026-09-19T01:55:45.040456Z","steps":["trace[1745331353] 'process raft request' (duration: 330.726793ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:45.040664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:55:44.709491Z","time spent":"331.085168ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:55:45.040866Z","caller":"traceutil/trace.go:171","msg":"trace[1156126072] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"321.546146ms","start":"2026-09-19T01:55:44.719256Z","end":"2026-09-19T01:55:45.040802Z","steps":["trace[1156126072] 'process raft request' (duration: 321.12179ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:45.041035Z","caller":"traceutil/trace.go:171","msg":"trace[2094129628] linearizableReadLoop","detail":"{readStateIndex:1953; appliedIndex:1950; }","duration":"321.568467ms","start":"2026-09-19T01:55:44.719445Z","end":"2026-09-19T01:55:45.041013Z","steps":["trace[2094129628] 'read index received' (duration: 188.757752ms)","trace[2094129628] 'applied index is now lower than readState.Index' (duration: 132.809715ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:55:45.041119Z","caller":"traceutil/trace.go:171","msg":"trace[1479344874] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"222.436205ms","start":"2026-09-19T01:55:44.818617Z","end":"2026-09-19T01:55:45.041053Z","steps":["trace[1479344874] 'process raft request' (duration: 222.032849ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:45.041064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:55:44.719232Z","time spent":"321.678549ms","remote":"127.0.0.1:41910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:55:45.04131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.61918ms","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-09-19T01:55:45.041359Z","caller":"traceutil/trace.go:171","msg":"trace[1448433910] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1880; }","duration":"165.70574ms","start":"2026-09-19T01:55:44.875639Z","end":"2026-09-19T01:55:45.041345Z","steps":["trace[1448433910] 'agreement among raft nodes before linearized reading' (duration: 165.539128ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:45.041479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.874891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-19T01:55:45.041594Z","caller":"traceutil/trace.go:171","msg":"trace[1921447077] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1880; }","duration":"322.199606ms","start":"2026-09-19T01:55:44.719375Z","end":"2026-09-19T01:55:45.041575Z","steps":["trace[1921447077] 'agreement among raft nodes before linearized reading' (duration: 321.742559ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:45.041806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:55:44.719361Z","time spent":"322.265876ms","remote":"127.0.0.1:46360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-19T01:55:58.010734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.233937ms","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-09-19T01:55:58.010847Z","caller":"traceutil/trace.go:171","msg":"trace[809050477] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1990; }","duration":"144.41562ms","start":"2026-09-19T01:55:57.866407Z","end":"2026-09-19T01:55:58.010823Z","steps":["trace[809050477] 'range keys from in-memory index tree' (duration: 144.015065ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:55:58.010798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.528949ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:55:58.011093Z","caller":"traceutil/trace.go:171","msg":"trace[1468044814] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1990; }","duration":"132.836133ms","start":"2026-09-19T01:55:57.878239Z","end":"2026-09-19T01:55:58.011075Z","steps":["trace[1468044814] 'range keys from in-memory index tree' (duration: 132.228614ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:56:19.885059Z","caller":"traceutil/trace.go:171","msg":"trace[1559465579] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"189.767489ms","start":"2026-09-19T01:56:19.695265Z","end":"2026-09-19T01:56:19.885032Z","steps":["trace[1559465579] 'process raft request' (duration: 167.418417ms)","trace[1559465579] 'compare' (duration: 22.245701ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:56:20.145006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.720125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:56:20.145192Z","caller":"traceutil/trace.go:171","msg":"trace[570725499] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"327.70743ms","start":"2026-09-19T01:56:19.817454Z","end":"2026-09-19T01:56:20.145162Z","steps":["trace[570725499] 'process raft request' (duration: 167.664211ms)","trace[570725499] 'compare' (duration: 159.489082ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:56:20.145313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:56:19.81743Z","time spent":"327.842631ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:56:20.576046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.416635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-19T01:56:20.576183Z","caller":"traceutil/trace.go:171","msg":"trace[1954963312] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2129; }","duration":"167.571327ms","start":"2026-09-19T01:56:20.408574Z","end":"2026-09-19T01:56:20.576146Z","steps":["trace[1954963312] 'range keys from in-memory index tree' (duration: 167.145012ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:57:25.477868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.265074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:57:25.478182Z","caller":"traceutil/trace.go:171","msg":"trace[365967213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2581; }","duration":"192.614287ms","start":"2026-09-19T01:57:25.285548Z","end":"2026-09-19T01:57:25.478162Z","steps":["trace[365967213] 'range keys from in-memory index tree' (duration: 192.18548ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:57:25.47823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.037914ms","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-09-19T01:57:25.478304Z","caller":"traceutil/trace.go:171","msg":"trace[447872558] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2581; }","duration":"185.141798ms","start":"2026-09-19T01:57:25.293147Z","end":"2026-09-19T01:57:25.478289Z","steps":["trace[447872558] 'range keys from in-memory index tree' (duration: 184.897589ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:57:25.478786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.772792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-09-19T01:57:25.478947Z","caller":"traceutil/trace.go:171","msg":"trace[2057990445] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2581; }","duration":"207.982159ms","start":"2026-09-19T01:57:25.270945Z","end":"2026-09-19T01:57:25.478927Z","steps":["trace[2057990445] 'range keys from in-memory index tree' (duration: 206.873528ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:58:01.976877Z","caller":"traceutil/trace.go:171","msg":"trace[297502782] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"228.43256ms","start":"2026-09-19T01:58:01.748416Z","end":"2026-09-19T01:58:01.976848Z","steps":["trace[297502782] 'process raft request' (duration: 137.32345ms)","trace[297502782] 'compare' (duration: 90.79838ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:58:01.976754Z","caller":"traceutil/trace.go:171","msg":"trace[55807198] linearizableReadLoop","detail":"{readStateIndex:2885; appliedIndex:2884; }","duration":"191.549517ms","start":"2026-09-19T01:58:01.785172Z","end":"2026-09-19T01:58:01.976722Z","steps":["trace[55807198] 'read index received' (duration: 100.559501ms)","trace[55807198] 'applied index is now lower than readState.Index' (duration: 90.988226ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:58:01.977351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.156566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:58:01.977525Z","caller":"traceutil/trace.go:171","msg":"trace[678981723] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2781; }","duration":"192.415704ms","start":"2026-09-19T01:58:01.785096Z","end":"2026-09-19T01:58:01.977512Z","steps":["trace[678981723] 'agreement among raft nodes before linearized reading' (duration: 192.158896ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:37.991673Z","caller":"traceutil/trace.go:171","msg":"trace[914154284] transaction","detail":"{read_only:false; response_revision:4809; number_of_response:1; }","duration":"110.557393ms","start":"2026-09-19T02:02:37.88109Z","end":"2026-09-19T02:02:37.991647Z","steps":["trace[914154284] 'process raft request' (duration: 109.849012ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:40.380717Z","caller":"traceutil/trace.go:171","msg":"trace[1718077725] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"239.366575ms","start":"2026-09-19T02:02:40.141331Z","end":"2026-09-19T02:02:40.380697Z","steps":["trace[1718077725] 'process raft request' (duration: 239.262674ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:40.400057Z","caller":"traceutil/trace.go:171","msg":"trace[887924593] linearizableReadLoop","detail":"{readStateIndex:5080; appliedIndex:5078; }","duration":"200.850695ms","start":"2026-09-19T02:02:40.199181Z","end":"2026-09-19T02:02:40.400032Z","steps":["trace[887924593] 'read index received' (duration: 181.431177ms)","trace[887924593] 'applied index is now lower than readState.Index' (duration: 19.418218ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:02:40.400177Z","caller":"traceutil/trace.go:171","msg":"trace[1253118127] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"214.23428ms","start":"2026-09-19T02:02:40.185932Z","end":"2026-09-19T02:02:40.400167Z","steps":["trace[1253118127] 'process raft request' (duration: 213.933155ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:02:40.40026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.78353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T02:02:40.400323Z","caller":"traceutil/trace.go:171","msg":"trace[1220302730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4893; }","duration":"114.868882ms","start":"2026-09-19T02:02:40.285441Z","end":"2026-09-19T02:02:40.400309Z","steps":["trace[1220302730] 'agreement among raft nodes before linearized reading' (duration: 114.77322ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:02:40.401486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.28014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-19T02:02:40.402185Z","caller":"traceutil/trace.go:171","msg":"trace[778396053] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4893; }","duration":"203.006592ms","start":"2026-09-19T02:02:40.199151Z","end":"2026-09-19T02:02:40.402158Z","steps":["trace[778396053] 'agreement among raft nodes before linearized reading' (duration: 201.375974ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:42.981043Z","caller":"traceutil/trace.go:171","msg":"trace[1815602710] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"149.921839ms","start":"2026-09-19T02:02:42.831094Z","end":"2026-09-19T02:02:42.981016Z","steps":["trace[1815602710] 'process raft request' (duration: 149.727846ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:49.022698Z","caller":"traceutil/trace.go:171","msg":"trace[1669262349] transaction","detail":"{read_only:false; response_revision:5056; number_of_response:1; }","duration":"255.135752ms","start":"2026-09-19T02:02:48.767544Z","end":"2026-09-19T02:02:49.022679Z","steps":["trace[1669262349] 'process raft request' (duration: 255.072481ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:49.022905Z","caller":"traceutil/trace.go:171","msg":"trace[427946519] linearizableReadLoop","detail":"{readStateIndex:5246; appliedIndex:5245; }","duration":"293.67728ms","start":"2026-09-19T02:02:48.729217Z","end":"2026-09-19T02:02:49.022894Z","steps":["trace[427946519] 'read index received' (duration: 271.915564ms)","trace[427946519] 'applied index is now lower than readState.Index' (duration: 21.760406ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T02:02:49.023066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.830472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T02:02:49.023103Z","caller":"traceutil/trace.go:171","msg":"trace[1191037479] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:5056; }","duration":"293.910574ms","start":"2026-09-19T02:02:48.729183Z","end":"2026-09-19T02:02:49.023094Z","steps":["trace[1191037479] 'agreement among raft nodes before linearized reading' (duration: 293.818083ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:49.022913Z","caller":"traceutil/trace.go:171","msg":"trace[1979378992] transaction","detail":"{read_only:false; response_revision:5055; number_of_response:1; }","duration":"319.698797ms","start":"2026-09-19T02:02:48.703178Z","end":"2026-09-19T02:02:49.022877Z","steps":["trace[1979378992] 'process raft request' (duration: 297.942081ms)","trace[1979378992] 'compare' (duration: 20.998983ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T02:02:49.023344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T02:02:48.703159Z","time spent":"320.097273ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T02:02:49.023429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.414775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T02:02:49.023465Z","caller":"traceutil/trace.go:171","msg":"trace[703542331] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:5056; }","duration":"122.467805ms","start":"2026-09-19T02:02:48.900986Z","end":"2026-09-19T02:02:49.023454Z","steps":["trace[703542331] 'agreement among raft nodes before linearized reading' (duration: 122.416414ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:02:49.023375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.316147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a7d5e3f4-e90d-4842-9559-919387e61593\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-19T02:02:49.02382Z","caller":"traceutil/trace.go:171","msg":"trace[2103211806] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a7d5e3f4-e90d-4842-9559-919387e61593; range_end:; response_count:1; response_revision:5056; }","duration":"127.785225ms","start":"2026-09-19T02:02:48.896012Z","end":"2026-09-19T02:02:49.023797Z","steps":["trace[2103211806] 'agreement among raft nodes before linearized reading' (duration: 127.260745ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:49.226288Z","caller":"traceutil/trace.go:171","msg":"trace[61297328] linearizableReadLoop","detail":"{readStateIndex:5249; appliedIndex:5247; }","duration":"181.400743ms","start":"2026-09-19T02:02:49.04486Z","end":"2026-09-19T02:02:49.226261Z","steps":["trace[61297328] 'read index received' (duration: 6.042602ms)","trace[61297328] 'applied index is now lower than readState.Index' (duration: 175.357051ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:02:49.226345Z","caller":"traceutil/trace.go:171","msg":"trace[1227176114] transaction","detail":"{read_only:false; response_revision:5058; number_of_response:1; }","duration":"184.82991ms","start":"2026-09-19T02:02:49.041486Z","end":"2026-09-19T02:02:49.226316Z","steps":["trace[1227176114] 'process raft request' (duration: 131.446585ms)","trace[1227176114] 'compare' (duration: 53.188012ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T02:02:49.226575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.688608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-09-19T02:02:49.226658Z","caller":"traceutil/trace.go:171","msg":"trace[1419990071] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5058; }","duration":"181.84002ms","start":"2026-09-19T02:02:49.044796Z","end":"2026-09-19T02:02:49.226636Z","steps":["trace[1419990071] 'agreement among raft nodes before linearized reading' (duration: 181.565486ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:02:49.226733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.268646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-19T02:02:49.226857Z","caller":"traceutil/trace.go:171","msg":"trace[1445766531] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5058; }","duration":"167.457029ms","start":"2026-09-19T02:02:49.05937Z","end":"2026-09-19T02:02:49.226827Z","steps":["trace[1445766531] 'agreement among raft nodes before linearized reading' (duration: 167.091653ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:49.63481Z","caller":"traceutil/trace.go:171","msg":"trace[1328569214] linearizableReadLoop","detail":"{readStateIndex:5261; appliedIndex:5256; }","duration":"119.573925ms","start":"2026-09-19T02:02:49.515208Z","end":"2026-09-19T02:02:49.634782Z","steps":["trace[1328569214] 'read index received' (duration: 32.207959ms)","trace[1328569214] 'applied index is now lower than readState.Index' (duration: 87.364666ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:02:49.635232Z","caller":"traceutil/trace.go:171","msg":"trace[1268416667] transaction","detail":"{read_only:false; response_revision:5069; number_of_response:1; }","duration":"247.068254ms","start":"2026-09-19T02:02:49.388105Z","end":"2026-09-19T02:02:49.635173Z","steps":["trace[1268416667] 'process raft request' (duration: 246.584956ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:49.635224Z","caller":"traceutil/trace.go:171","msg":"trace[1731720143] transaction","detail":"{read_only:false; response_revision:5070; number_of_response:1; }","duration":"241.761906ms","start":"2026-09-19T02:02:49.393432Z","end":"2026-09-19T02:02:49.635194Z","steps":["trace[1731720143] 'process raft request' (duration: 241.302559ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:02:49.635334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.116335ms","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-09-19T02:02:49.635382Z","caller":"traceutil/trace.go:171","msg":"trace[641949458] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5070; }","duration":"120.220946ms","start":"2026-09-19T02:02:49.515148Z","end":"2026-09-19T02:02:49.635369Z","steps":["trace[641949458] 'agreement among raft nodes before linearized reading' (duration: 120.030303ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:49.635402Z","caller":"traceutil/trace.go:171","msg":"trace[1861495954] transaction","detail":"{read_only:false; response_revision:5066; number_of_response:1; }","duration":"247.46918ms","start":"2026-09-19T02:02:49.387899Z","end":"2026-09-19T02:02:49.635368Z","steps":["trace[1861495954] 'process raft request' (duration: 159.424453ms)","trace[1861495954] 'compare' (duration: 86.889817ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:02:49.635582Z","caller":"traceutil/trace.go:171","msg":"trace[430960831] transaction","detail":"{read_only:false; response_revision:5068; number_of_response:1; }","duration":"247.517551ms","start":"2026-09-19T02:02:49.388037Z","end":"2026-09-19T02:02:49.635554Z","steps":["trace[430960831] 'process raft request' (duration: 246.578356ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:49.635631Z","caller":"traceutil/trace.go:171","msg":"trace[2024484111] transaction","detail":"{read_only:false; response_revision:5067; number_of_response:1; }","duration":"247.631293ms","start":"2026-09-19T02:02:49.387983Z","end":"2026-09-19T02:02:49.635614Z","steps":["trace[2024484111] 'process raft request' (duration: 246.576886ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:49.780904Z","caller":"traceutil/trace.go:171","msg":"trace[182536100] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"101.89747ms","start":"2026-09-19T02:02:49.678985Z","end":"2026-09-19T02:02:49.780883Z","steps":["trace[182536100] 'process raft request' (duration: 66.410144ms)","trace[182536100] 'compare' (duration: 35.178421ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T02:03:03.498805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.178021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10395"} {"level":"info","ts":"2026-09-19T02:03:03.499084Z","caller":"traceutil/trace.go:171","msg":"trace[2065676959] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5233; }","duration":"291.524146ms","start":"2026-09-19T02:03:03.20753Z","end":"2026-09-19T02:03:03.499055Z","steps":["trace[2065676959] 'range keys from in-memory index tree' (duration: 290.937396ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:03:03.499624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.18212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-19T02:03:03.499968Z","caller":"traceutil/trace.go:171","msg":"trace[238134017] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5233; }","duration":"212.537926ms","start":"2026-09-19T02:03:03.287352Z","end":"2026-09-19T02:03:03.49989Z","steps":["trace[238134017] 'range keys from in-memory index tree' (duration: 210.96701ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:03:03.741995Z","caller":"traceutil/trace.go:171","msg":"trace[1999939326] transaction","detail":"{read_only:false; response_revision:5234; number_of_response:1; }","duration":"229.193341ms","start":"2026-09-19T02:03:03.51276Z","end":"2026-09-19T02:03:03.741953Z","steps":["trace[1999939326] 'process raft request' (duration: 229.018628ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:03:03.983951Z","caller":"traceutil/trace.go:171","msg":"trace[1507607242] transaction","detail":"{read_only:false; response_revision:5241; number_of_response:1; }","duration":"141.289735ms","start":"2026-09-19T02:03:03.84263Z","end":"2026-09-19T02:03:03.98392Z","steps":["trace[1507607242] 'process raft request' (duration: 98.450804ms)","trace[1507607242] 'compare' (duration: 42.618337ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:03:03.984399Z","caller":"traceutil/trace.go:171","msg":"trace[880789119] transaction","detail":"{read_only:false; response_revision:5243; number_of_response:1; }","duration":"127.317392ms","start":"2026-09-19T02:03:03.857074Z","end":"2026-09-19T02:03:03.984391Z","steps":["trace[880789119] 'process raft request' (duration: 127.000076ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:03:03.984193Z","caller":"traceutil/trace.go:171","msg":"trace[1038063165] transaction","detail":"{read_only:false; response_revision:5242; number_of_response:1; }","duration":"134.449931ms","start":"2026-09-19T02:03:03.849725Z","end":"2026-09-19T02:03:03.984175Z","steps":["trace[1038063165] 'process raft request' (duration: 134.093655ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:03:04.124317Z","caller":"traceutil/trace.go:171","msg":"trace[1179903403] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"126.435317ms","start":"2026-09-19T02:03:03.99783Z","end":"2026-09-19T02:03:04.124265Z","steps":["trace[1179903403] 'process raft request' (duration: 105.719473ms)","trace[1179903403] 'compare' (duration: 20.50232ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:03:24.23273Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2903} {"level":"info","ts":"2026-09-19T02:03:24.311936Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2903,"took":"77.456706ms","hash":4021214322,"current-db-size-bytes":51421184,"current-db-size":"51 MB","current-db-size-in-use-bytes":27779072,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-19T02:03:24.312037Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4021214322,"revision":2903,"compact-revision":-1} {"level":"info","ts":"2026-09-19T02:08:24.244212Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5381} {"level":"info","ts":"2026-09-19T02:08:24.329491Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5381,"took":"83.842043ms","hash":488428212,"current-db-size-bytes":51421184,"current-db-size":"51 MB","current-db-size-in-use-bytes":18636800,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-19T02:08:24.329544Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":488428212,"revision":5381,"compact-revision":2903}