{"level":"warn","ts":"2026-09-11T15:14:56.344594Z","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-11T15:14:56.34473Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.242: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.242:2380","--initial-cluster=instance=https://162.253.55.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.242: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-11T15:14:56.344869Z","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-11T15:14:56.344885Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.242:2380"]} {"level":"info","ts":"2026-09-11T15:14:56.345094Z","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-11T15:14:56.34819Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.242:2379"]} {"level":"info","ts":"2026-09-11T15:14:56.348374Z","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.242:2380"],"listen-peer-urls":["https://162.253.55.242:2380"],"advertise-client-urls":["https://162.253.55.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.242: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-11T15:14:56.352743Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.03993ms"} {"level":"info","ts":"2026-09-11T15:14:56.358604Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cc70bec9404419f6","cluster-id":"38671954b404c50e"} {"level":"info","ts":"2026-09-11T15:14:56.358702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 switched to configuration voters=()"} {"level":"info","ts":"2026-09-11T15:14:56.358733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 became follower at term 0"} {"level":"info","ts":"2026-09-11T15:14:56.35875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cc70bec9404419f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-11T15:14:56.358791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 became follower at term 1"} {"level":"info","ts":"2026-09-11T15:14:56.358866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 switched to configuration voters=(14731484152704801270)"} {"level":"warn","ts":"2026-09-11T15:14:56.36831Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-11T15:14:56.369677Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-11T15:14:56.370766Z","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-11T15:14:56.372956Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cc70bec9404419f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-11T15:14:56.37454Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cc70bec9404419f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-11T15:14:56.375139Z","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-11T15:14:56.375211Z","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-11T15:14:56.375224Z","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-11T15:14:56.376307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 switched to configuration voters=(14731484152704801270)"} {"level":"info","ts":"2026-09-11T15:14:56.376461Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"38671954b404c50e","local-member-id":"cc70bec9404419f6","added-peer-id":"cc70bec9404419f6","added-peer-peer-urls":["https://162.253.55.242:2380"]} {"level":"info","ts":"2026-09-11T15:14:56.376837Z","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-11T15:14:56.376909Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.242:2380"} {"level":"info","ts":"2026-09-11T15:14:56.376928Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.242:2380"} {"level":"info","ts":"2026-09-11T15:14:56.377069Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cc70bec9404419f6","initial-advertise-peer-urls":["https://162.253.55.242:2380"],"listen-peer-urls":["https://162.253.55.242:2380"],"advertise-client-urls":["https://162.253.55.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-11T15:14:56.377111Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-11T15:14:57.059962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 is starting a new election at term 1"} {"level":"info","ts":"2026-09-11T15:14:57.060029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-11T15:14:57.060051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 received MsgPreVoteResp from cc70bec9404419f6 at term 1"} {"level":"info","ts":"2026-09-11T15:14:57.060069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 became candidate at term 2"} {"level":"info","ts":"2026-09-11T15:14:57.060085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 received MsgVoteResp from cc70bec9404419f6 at term 2"} {"level":"info","ts":"2026-09-11T15:14:57.060117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cc70bec9404419f6 became leader at term 2"} {"level":"info","ts":"2026-09-11T15:14:57.060134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cc70bec9404419f6 elected leader cc70bec9404419f6 at term 2"} {"level":"info","ts":"2026-09-11T15:14:57.061198Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T15:14:57.062373Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-11T15:14:57.062377Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cc70bec9404419f6","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.242:2379]}","request-path":"/0/members/cc70bec9404419f6/attributes","cluster-id":"38671954b404c50e","publish-timeout":"7s"} {"level":"info","ts":"2026-09-11T15:14:57.062903Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-11T15:14:57.06306Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-11T15:14:57.064926Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-11T15:14:57.066981Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"38671954b404c50e","local-member-id":"cc70bec9404419f6","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T15:14:57.067106Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T15:14:57.067142Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T15:14:57.067479Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-11T15:14:57.070316Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.242:2379"} {"level":"warn","ts":"2026-09-11T15:15:16.799496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.322009ms","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-11T15:15:16.799599Z","caller":"traceutil/trace.go:171","msg":"trace[1172516929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:426; }","duration":"153.495434ms","start":"2026-09-11T15:15:16.646081Z","end":"2026-09-11T15:15:16.799577Z","steps":["trace[1172516929] 'range keys from in-memory index tree' (duration: 153.121403ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:15:42.835144Z","caller":"traceutil/trace.go:171","msg":"trace[859290860] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"179.55357ms","start":"2026-09-11T15:15:42.655553Z","end":"2026-09-11T15:15:42.835106Z","steps":["trace[859290860] 'process raft request' (duration: 179.323813ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:15:43.480358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.070142ms","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-11T15:15:43.480476Z","caller":"traceutil/trace.go:171","msg":"trace[454980310] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:701; }","duration":"500.235627ms","start":"2026-09-11T15:15:42.980208Z","end":"2026-09-11T15:15:43.480443Z","steps":["trace[454980310] 'range keys from in-memory index tree' (duration: 499.808074ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:15:43.480458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.545854ms","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-09-11T15:15:43.480585Z","caller":"traceutil/trace.go:171","msg":"trace[1984913910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:701; }","duration":"421.721479ms","start":"2026-09-11T15:15:43.058838Z","end":"2026-09-11T15:15:43.48056Z","steps":["trace[1984913910] 'range keys from in-memory index tree' (duration: 421.350439ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:15:43.480582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T15:15:42.980184Z","time spent":"500.332949ms","remote":"127.0.0.1:44174","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":"warn","ts":"2026-09-11T15:15:43.480659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T15:15:43.058823Z","time spent":"421.824353ms","remote":"127.0.0.1:44174","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-09-11T15:15:43.48082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.021649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-11T15:15:43.480859Z","caller":"traceutil/trace.go:171","msg":"trace[1560592648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:701; }","duration":"422.105401ms","start":"2026-09-11T15:15:43.058739Z","end":"2026-09-11T15:15:43.480844Z","steps":["trace[1560592648] 'range keys from in-memory index tree' (duration: 421.893825ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:15:43.480892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T15:15:43.058694Z","time spent":"422.190084ms","remote":"127.0.0.1:44174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-11T15:15:43.480987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.373616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-11T15:15:43.481076Z","caller":"traceutil/trace.go:171","msg":"trace[265532952] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:701; }","duration":"418.489389ms","start":"2026-09-11T15:15:43.062568Z","end":"2026-09-11T15:15:43.481058Z","steps":["trace[265532952] 'range keys from in-memory index tree' (duration: 418.212771ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:15:43.481131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T15:15:43.062556Z","time spent":"418.560941ms","remote":"127.0.0.1:44174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-11T15:16:07.174754Z","caller":"traceutil/trace.go:171","msg":"trace[1553866724] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"209.412643ms","start":"2026-09-11T15:16:06.965285Z","end":"2026-09-11T15:16:07.174698Z","steps":["trace[1553866724] 'process raft request' (duration: 209.125813ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:16:37.483417Z","caller":"traceutil/trace.go:171","msg":"trace[654307046] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"133.599166ms","start":"2026-09-11T15:16:37.349794Z","end":"2026-09-11T15:16:37.483393Z","steps":["trace[654307046] 'process raft request' (duration: 133.470052ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:17:29.885144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.559161ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-11T15:17:29.885263Z","caller":"traceutil/trace.go:171","msg":"trace[1371178716] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"272.580962ms","start":"2026-09-11T15:17:29.612671Z","end":"2026-09-11T15:17:29.885252Z","steps":["trace[1371178716] 'process raft request' (duration: 272.5421ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:17:29.885402Z","caller":"traceutil/trace.go:171","msg":"trace[1233194973] linearizableReadLoop","detail":"{readStateIndex:2008; appliedIndex:2007; }","duration":"401.764622ms","start":"2026-09-11T15:17:29.483578Z","end":"2026-09-11T15:17:29.885342Z","steps":["trace[1233194973] 'read index received' (duration: 122.525891ms)","trace[1233194973] 'applied index is now lower than readState.Index' (duration: 279.233271ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T15:17:29.885531Z","caller":"traceutil/trace.go:171","msg":"trace[738307620] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"565.467882ms","start":"2026-09-11T15:17:29.320056Z","end":"2026-09-11T15:17:29.885524Z","steps":["trace[738307620] 'process raft request' (duration: 286.108797ms)","trace[738307620] 'compare' (duration: 278.342065ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T15:17:29.88557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T15:17:29.320024Z","time spent":"565.525714ms","remote":"127.0.0.1:44174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-11T15:17:29.885872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.293948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T15:17:29.885893Z","caller":"traceutil/trace.go:171","msg":"trace[1063647020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1938; }","duration":"402.35428ms","start":"2026-09-11T15:17:29.483532Z","end":"2026-09-11T15:17:29.885886Z","steps":["trace[1063647020] 'agreement among raft nodes before linearized reading' (duration: 402.319099ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:17:29.885906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T15:17:29.483514Z","time spent":"402.389531ms","remote":"127.0.0.1:43972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-11T15:17:29.886887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.828698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T15:17:29.88692Z","caller":"traceutil/trace.go:171","msg":"trace[1236216190] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1938; }","duration":"288.8942ms","start":"2026-09-11T15:17:29.598012Z","end":"2026-09-11T15:17:29.886906Z","steps":["trace[1236216190] 'agreement among raft nodes before linearized reading' (duration: 288.843368ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:17:29.886934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.277742ms","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-11T15:17:29.887106Z","caller":"traceutil/trace.go:171","msg":"trace[1900850369] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1938; }","duration":"118.528011ms","start":"2026-09-11T15:17:29.768549Z","end":"2026-09-11T15:17:29.887077Z","steps":["trace[1900850369] 'agreement among raft nodes before linearized reading' (duration: 118.119858ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:17:29.88702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.400024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-11T15:17:29.887219Z","caller":"traceutil/trace.go:171","msg":"trace[1303412959] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1938; }","duration":"378.814287ms","start":"2026-09-11T15:17:29.508395Z","end":"2026-09-11T15:17:29.887209Z","steps":["trace[1303412959] 'agreement among raft nodes before linearized reading' (duration: 378.208668ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:17:29.88725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T15:17:29.508372Z","time spent":"378.867428ms","remote":"127.0.0.1:45740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-09-11T15:17:30.097934Z","caller":"traceutil/trace.go:171","msg":"trace[1523739527] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"139.253079ms","start":"2026-09-11T15:17:29.958645Z","end":"2026-09-11T15:17:30.097898Z","steps":["trace[1523739527] 'process raft request' (duration: 115.063587ms)","trace[1523739527] 'compare' (duration: 23.842402ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T15:17:42.882777Z","caller":"traceutil/trace.go:171","msg":"trace[682301327] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"232.898939ms","start":"2026-09-11T15:17:42.649754Z","end":"2026-09-11T15:17:42.882653Z","steps":["trace[682301327] 'process raft request' (duration: 232.651901ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:18:04.823992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.296882ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-11T15:18:04.824186Z","caller":"traceutil/trace.go:171","msg":"trace[1453391667] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"225.955049ms","start":"2026-09-11T15:18:04.598212Z","end":"2026-09-11T15:18:04.824167Z","steps":["trace[1453391667] 'process raft request' (duration: 225.879087ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:18:04.824349Z","caller":"traceutil/trace.go:171","msg":"trace[2054439237] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"225.408654ms","start":"2026-09-11T15:18:04.598927Z","end":"2026-09-11T15:18:04.824335Z","steps":["trace[2054439237] 'process raft request' (duration: 225.207598ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:18:04.824325Z","caller":"traceutil/trace.go:171","msg":"trace[224798255] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"226.114364ms","start":"2026-09-11T15:18:04.598154Z","end":"2026-09-11T15:18:04.824268Z","steps":["trace[224798255] 'process raft request' (duration: 102.450211ms)","trace[224798255] 'compare' (duration: 123.185379ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T15:18:05.612164Z","caller":"traceutil/trace.go:171","msg":"trace[1239712231] linearizableReadLoop","detail":"{readStateIndex:2261; appliedIndex:2260; }","duration":"128.886179ms","start":"2026-09-11T15:18:05.483254Z","end":"2026-09-11T15:18:05.61214Z","steps":["trace[1239712231] 'read index received' (duration: 128.704863ms)","trace[1239712231] 'applied index is now lower than readState.Index' (duration: 180.466µs)"],"step_count":2} {"level":"warn","ts":"2026-09-11T15:18:05.612278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.002162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T15:18:05.612309Z","caller":"traceutil/trace.go:171","msg":"trace[1287586124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2183; }","duration":"129.075754ms","start":"2026-09-11T15:18:05.483223Z","end":"2026-09-11T15:18:05.612298Z","steps":["trace[1287586124] 'agreement among raft nodes before linearized reading' (duration: 129.008572ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:18:05.612302Z","caller":"traceutil/trace.go:171","msg":"trace[358921807] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"132.218549ms","start":"2026-09-11T15:18:05.479983Z","end":"2026-09-11T15:18:05.612202Z","steps":["trace[358921807] 'process raft request' (duration: 132.027963ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:18:06.069926Z","caller":"traceutil/trace.go:171","msg":"trace[842383028] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"129.304561ms","start":"2026-09-11T15:18:05.94058Z","end":"2026-09-11T15:18:06.069885Z","steps":["trace[842383028] 'process raft request' (duration: 129.129956ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:18:06.398234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.314005ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-11T15:18:06.398462Z","caller":"traceutil/trace.go:171","msg":"trace[909813976] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"395.483547ms","start":"2026-09-11T15:18:06.002942Z","end":"2026-09-11T15:18:06.398426Z","steps":["trace[909813976] 'process raft request' (duration: 280.195304ms)","trace[909813976] 'compare' (duration: 114.17742ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T15:18:06.398514Z","caller":"traceutil/trace.go:171","msg":"trace[128101582] linearizableReadLoop","detail":"{readStateIndex:2266; appliedIndex:2263; }","duration":"239.908484ms","start":"2026-09-11T15:18:06.158584Z","end":"2026-09-11T15:18:06.398492Z","steps":["trace[128101582] 'read index received' (duration: 124.56354ms)","trace[128101582] 'applied index is now lower than readState.Index' (duration: 115.343364ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T15:18:06.398796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T15:18:06.002913Z","time spent":"395.622091ms","remote":"127.0.0.1:44114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8560,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-11T15:18:06.398859Z","caller":"traceutil/trace.go:171","msg":"trace[920637546] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"388.235633ms","start":"2026-09-11T15:18:06.010607Z","end":"2026-09-11T15:18:06.398842Z","steps":["trace[920637546] 'process raft request' (duration: 387.734037ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:18:06.398983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T15:18:06.010594Z","time spent":"388.304184ms","remote":"127.0.0.1:44174","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-11T15:18:06.399252Z","caller":"traceutil/trace.go:171","msg":"trace[53678188] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"357.411203ms","start":"2026-09-11T15:18:06.041827Z","end":"2026-09-11T15:18:06.399238Z","steps":["trace[53678188] 'process raft request' (duration: 356.612759ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:18:06.399328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T15:18:06.041814Z","time spent":"357.476616ms","remote":"127.0.0.1:44174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-11T15:18:06.399504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.916584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-09-11T15:18:06.399517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.328432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-11T15:18:06.399565Z","caller":"traceutil/trace.go:171","msg":"trace[656845040] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2187; }","duration":"240.978256ms","start":"2026-09-11T15:18:06.15857Z","end":"2026-09-11T15:18:06.399548Z","steps":["trace[656845040] 'agreement among raft nodes before linearized reading' (duration: 240.76219ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:18:06.399585Z","caller":"traceutil/trace.go:171","msg":"trace[444256555] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2187; }","duration":"176.441895ms","start":"2026-09-11T15:18:06.223125Z","end":"2026-09-11T15:18:06.399567Z","steps":["trace[444256555] 'agreement among raft nodes before linearized reading' (duration: 176.245329ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:18:06.638595Z","caller":"traceutil/trace.go:171","msg":"trace[1405212289] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"233.282597ms","start":"2026-09-11T15:18:06.40528Z","end":"2026-09-11T15:18:06.638562Z","steps":["trace[1405212289] 'process raft request' (duration: 184.193075ms)","trace[1405212289] 'compare' (duration: 48.548556ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T15:18:06.828002Z","caller":"traceutil/trace.go:171","msg":"trace[2095782721] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"184.972739ms","start":"2026-09-11T15:18:06.643007Z","end":"2026-09-11T15:18:06.827979Z","steps":["trace[2095782721] 'process raft request' (duration: 171.175378ms)","trace[2095782721] 'compare' (duration: 13.375348ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T15:19:20.811804Z","caller":"traceutil/trace.go:171","msg":"trace[1752566021] transaction","detail":"{read_only:false; response_revision:2686; number_of_response:1; }","duration":"129.870577ms","start":"2026-09-11T15:19:20.681914Z","end":"2026-09-11T15:19:20.811785Z","steps":["trace[1752566021] 'process raft request' (duration: 129.727913ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:19:20.821853Z","caller":"traceutil/trace.go:171","msg":"trace[350474123] transaction","detail":"{read_only:false; response_revision:2687; number_of_response:1; }","duration":"134.396087ms","start":"2026-09-11T15:19:20.687429Z","end":"2026-09-11T15:19:20.821825Z","steps":["trace[350474123] 'process raft request' (duration: 134.273673ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:19:53.871765Z","caller":"traceutil/trace.go:171","msg":"trace[1347611327] transaction","detail":"{read_only:false; response_revision:2871; number_of_response:1; }","duration":"157.923199ms","start":"2026-09-11T15:19:53.713819Z","end":"2026-09-11T15:19:53.871742Z","steps":["trace[1347611327] 'process raft request' (duration: 157.792536ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:24:26.311454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.591722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T15:24:26.311531Z","caller":"traceutil/trace.go:171","msg":"trace[2076423263] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4985; }","duration":"100.706144ms","start":"2026-09-11T15:24:26.210809Z","end":"2026-09-11T15:24:26.311515Z","steps":["trace[2076423263] 'range keys from in-memory index tree' (duration: 100.532168ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:24:33.193468Z","caller":"traceutil/trace.go:171","msg":"trace[2052274537] linearizableReadLoop","detail":"{readStateIndex:5227; appliedIndex:5226; }","duration":"145.237315ms","start":"2026-09-11T15:24:33.0482Z","end":"2026-09-11T15:24:33.193438Z","steps":["trace[2052274537] 'read index received' (duration: 144.302808ms)","trace[2052274537] 'applied index is now lower than readState.Index' (duration: 932.787µs)"],"step_count":2} {"level":"info","ts":"2026-09-11T15:24:33.193654Z","caller":"traceutil/trace.go:171","msg":"trace[465538610] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"153.228007ms","start":"2026-09-11T15:24:33.040273Z","end":"2026-09-11T15:24:33.193501Z","steps":["trace[465538610] 'process raft request' (duration: 152.350061ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:24:33.193789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.562095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-11T15:24:33.193849Z","caller":"traceutil/trace.go:171","msg":"trace[315343641] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5039; }","duration":"145.691228ms","start":"2026-09-11T15:24:33.048146Z","end":"2026-09-11T15:24:33.193837Z","steps":["trace[315343641] 'agreement among raft nodes before linearized reading' (duration: 145.462342ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:24:33.193782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.639401ms","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-11T15:24:33.194016Z","caller":"traceutil/trace.go:171","msg":"trace[832980031] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5039; }","duration":"141.911678ms","start":"2026-09-11T15:24:33.052093Z","end":"2026-09-11T15:24:33.194004Z","steps":["trace[832980031] 'agreement among raft nodes before linearized reading' (duration: 141.551508ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T15:24:33.194058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.350792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-11T15:24:33.194109Z","caller":"traceutil/trace.go:171","msg":"trace[970131398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5039; }","duration":"141.410824ms","start":"2026-09-11T15:24:33.052682Z","end":"2026-09-11T15:24:33.194093Z","steps":["trace[970131398] 'agreement among raft nodes before linearized reading' (duration: 141.317562ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:24:47.397551Z","caller":"traceutil/trace.go:171","msg":"trace[1315321420] transaction","detail":"{read_only:false; response_revision:5282; number_of_response:1; }","duration":"149.972926ms","start":"2026-09-11T15:24:47.247553Z","end":"2026-09-11T15:24:47.397526Z","steps":["trace[1315321420] 'process raft request' (duration: 149.717589ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:24:47.770059Z","caller":"traceutil/trace.go:171","msg":"trace[77815058] transaction","detail":"{read_only:false; response_revision:5290; number_of_response:1; }","duration":"107.561366ms","start":"2026-09-11T15:24:47.662467Z","end":"2026-09-11T15:24:47.770028Z","steps":["trace[77815058] 'process raft request' (duration: 107.491234ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:24:47.770326Z","caller":"traceutil/trace.go:171","msg":"trace[1172100906] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"115.500428ms","start":"2026-09-11T15:24:47.654803Z","end":"2026-09-11T15:24:47.770304Z","steps":["trace[1172100906] 'process raft request' (duration: 21.214685ms)","trace[1172100906] 'compare' (duration: 93.687695ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T15:24:47.770443Z","caller":"traceutil/trace.go:171","msg":"trace[518095194] transaction","detail":"{read_only:false; response_revision:5289; number_of_response:1; }","duration":"111.647345ms","start":"2026-09-11T15:24:47.658779Z","end":"2026-09-11T15:24:47.770426Z","steps":["trace[518095194] 'process raft request' (duration: 111.101369ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:24:57.092784Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2886} {"level":"info","ts":"2026-09-11T15:24:57.169007Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2886,"took":"74.753817ms","hash":44380358,"current-db-size-bytes":52379648,"current-db-size":"52 MB","current-db-size-in-use-bytes":27627520,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-11T15:24:57.169097Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":44380358,"revision":2886,"compact-revision":-1} {"level":"info","ts":"2026-09-11T15:29:00.219672Z","caller":"traceutil/trace.go:171","msg":"trace[59681960] transaction","detail":"{read_only:false; response_revision:7101; number_of_response:1; }","duration":"145.031097ms","start":"2026-09-11T15:29:00.074616Z","end":"2026-09-11T15:29:00.219647Z","steps":["trace[59681960] 'process raft request' (duration: 144.929484ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T15:29:57.09991Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5356} {"level":"info","ts":"2026-09-11T15:29:57.222921Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5356,"took":"121.59647ms","hash":3670087214,"current-db-size-bytes":52379648,"current-db-size":"52 MB","current-db-size-in-use-bytes":19005440,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-11T15:29:57.223013Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3670087214,"revision":5356,"compact-revision":2886} {"level":"info","ts":"2026-09-11T15:34:57.108969Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7417} {"level":"info","ts":"2026-09-11T15:34:57.172525Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7417,"took":"61.564464ms","hash":2390639474,"current-db-size-bytes":52379648,"current-db-size":"52 MB","current-db-size-in-use-bytes":15429632,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-09-11T15:34:57.172626Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2390639474,"revision":7417,"compact-revision":5356}