{"level":"warn","ts":"2026-02-17T06:35:35.769832Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-17T06:35:35.769929Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-02-17T06:35:35.770004Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-17T06:35:35.770014Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-02-17T06:35:35.77003Z","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-02-17T06:35:35.771075Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-02-17T06:35:35.771159Z","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":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-02-17T06:35:35.775631Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.053163ms"} {"level":"info","ts":"2026-02-17T06:35:35.800189Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-02-17T06:35:35.800244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T06:35:35.800259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-02-17T06:35:35.800266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T06:35:35.800274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-02-17T06:35:35.800304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-02-17T06:35:35.806027Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T06:35:35.807142Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T06:35:35.8083Z","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-02-17T06:35:35.810886Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T06:35:35.811955Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T06:35:35.813549Z","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-02-17T06:35:35.813576Z","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-02-17T06:35:35.813583Z","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-02-17T06:35:35.814065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-02-17T06:35:35.814171Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-02-17T06:35:35.824973Z","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-02-17T06:35:35.825202Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T06:35:35.825224Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T06:35:35.825306Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-02-17T06:35:35.825319Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-02-17T06:35:35.902526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T06:35:35.902554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T06:35:35.902659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-02-17T06:35:35.902676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-02-17T06:35:35.902685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-02-17T06:35:35.902694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-02-17T06:35:35.902721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-02-17T06:35:35.904726Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:35:35.909036Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T06:35:35.909208Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T06:35:35.909496Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T06:35:35.911Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T06:35:35.911353Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T06:35:35.911368Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T06:35:35.9116Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:35:35.911773Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:35:35.911842Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:35:35.965635Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-02-17T06:36:08.615944Z","caller":"traceutil/trace.go:171","msg":"trace[1080070845] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:494; }","duration":"123.196699ms","start":"2026-02-17T06:36:08.492726Z","end":"2026-02-17T06:36:08.615923Z","steps":["trace[1080070845] 'read index received' (duration: 122.958272ms)","trace[1080070845] 'applied index is now lower than readState.Index' (duration: 236.937µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:36:08.616142Z","caller":"traceutil/trace.go:171","msg":"trace[1927521626] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"340.672862ms","start":"2026-02-17T06:36:08.275455Z","end":"2026-02-17T06:36:08.616128Z","steps":["trace[1927521626] 'process raft request' (duration: 340.290763ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:08.616968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.213923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-17T06:36:08.617001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:08.275422Z","time spent":"340.746794ms","remote":"127.0.0.1:32996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4253,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:08.617109Z","caller":"traceutil/trace.go:171","msg":"trace[1422246145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:480; }","duration":"124.373436ms","start":"2026-02-17T06:36:08.492708Z","end":"2026-02-17T06:36:08.617082Z","steps":["trace[1422246145] 'agreement among raft nodes before linearized reading' (duration: 124.142501ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:15.763099Z","caller":"traceutil/trace.go:171","msg":"trace[1442314830] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:518; }","duration":"123.27023ms","start":"2026-02-17T06:36:15.639803Z","end":"2026-02-17T06:36:15.763073Z","steps":["trace[1442314830] 'read index received' (duration: 123.033785ms)","trace[1442314830] 'applied index is now lower than readState.Index' (duration: 235.575µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:15.763362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.530747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gkljz\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-17T06:36:15.763399Z","caller":"traceutil/trace.go:171","msg":"trace[1237067187] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gkljz; range_end:; response_count:1; response_revision:502; }","duration":"123.631889ms","start":"2026-02-17T06:36:15.639757Z","end":"2026-02-17T06:36:15.763388Z","steps":["trace[1237067187] 'agreement among raft nodes before linearized reading' (duration: 123.413824ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:15.76347Z","caller":"traceutil/trace.go:171","msg":"trace[1417566789] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"259.423509ms","start":"2026-02-17T06:36:15.504009Z","end":"2026-02-17T06:36:15.763432Z","steps":["trace[1417566789] 'process raft request' (duration: 258.896395ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:17.95216Z","caller":"traceutil/trace.go:171","msg":"trace[63475196] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:542; }","duration":"110.007204ms","start":"2026-02-17T06:36:17.842096Z","end":"2026-02-17T06:36:17.952103Z","steps":["trace[63475196] 'read index received' (duration: 87.087078ms)","trace[63475196] 'applied index is now lower than readState.Index' (duration: 22.918716ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:36:17.95275Z","caller":"traceutil/trace.go:171","msg":"trace[693074439] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"120.813159ms","start":"2026-02-17T06:36:17.831903Z","end":"2026-02-17T06:36:17.952716Z","steps":["trace[693074439] 'process raft request' (duration: 97.418342ms)","trace[693074439] 'compare' (duration: 22.197537ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:17.953337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.219784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:17.953391Z","caller":"traceutil/trace.go:171","msg":"trace[1729570204] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:526; }","duration":"111.328006ms","start":"2026-02-17T06:36:17.842049Z","end":"2026-02-17T06:36:17.953377Z","steps":["trace[1729570204] 'agreement among raft nodes before linearized reading' (duration: 111.234734ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:17.959875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.669329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:17.96035Z","caller":"traceutil/trace.go:171","msg":"trace[751035842] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:526; }","duration":"113.14173ms","start":"2026-02-17T06:36:17.847181Z","end":"2026-02-17T06:36:17.960322Z","steps":["trace[751035842] 'agreement among raft nodes before linearized reading' (duration: 112.662628ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:17.960072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.709475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-17T06:36:17.960131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.590157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:17.962185Z","caller":"traceutil/trace.go:171","msg":"trace[780329670] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:526; }","duration":"114.648797ms","start":"2026-02-17T06:36:17.847524Z","end":"2026-02-17T06:36:17.962173Z","steps":["trace[780329670] 'agreement among raft nodes before linearized reading' (duration: 112.588806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:17.960187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.927146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:17.962397Z","caller":"traceutil/trace.go:171","msg":"trace[1015989602] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:526; }","duration":"115.16027ms","start":"2026-02-17T06:36:17.847227Z","end":"2026-02-17T06:36:17.962387Z","steps":["trace[1015989602] 'agreement among raft nodes before linearized reading' (duration: 112.925135ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:17.960215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.991358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:17.962573Z","caller":"traceutil/trace.go:171","msg":"trace[2132676209] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:526; }","duration":"115.353685ms","start":"2026-02-17T06:36:17.847212Z","end":"2026-02-17T06:36:17.962566Z","steps":["trace[2132676209] 'agreement among raft nodes before linearized reading' (duration: 112.989598ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:17.960265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.589038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:17.962753Z","caller":"traceutil/trace.go:171","msg":"trace[857270849] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:526; }","duration":"111.102129ms","start":"2026-02-17T06:36:17.851643Z","end":"2026-02-17T06:36:17.962745Z","steps":["trace[857270849] 'agreement among raft nodes before linearized reading' (duration: 108.589298ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:17.9603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.213624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:17.963725Z","caller":"traceutil/trace.go:171","msg":"trace[1509648686] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:526; }","duration":"112.643698ms","start":"2026-02-17T06:36:17.851072Z","end":"2026-02-17T06:36:17.963715Z","steps":["trace[1509648686] 'agreement among raft nodes before linearized reading' (duration: 109.211433ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:17.963856Z","caller":"traceutil/trace.go:171","msg":"trace[2063307849] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:526; }","duration":"112.222037ms","start":"2026-02-17T06:36:17.848344Z","end":"2026-02-17T06:36:17.960566Z","steps":["trace[2063307849] 'agreement among raft nodes before linearized reading' (duration: 111.703205ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:26.177255Z","caller":"traceutil/trace.go:171","msg":"trace[885802283] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"147.435936ms","start":"2026-02-17T06:36:26.029792Z","end":"2026-02-17T06:36:26.177228Z","steps":["trace[885802283] 'process raft request' (duration: 83.298194ms)","trace[885802283] 'compare' (duration: 64.011149ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:36:36.020042Z","caller":"traceutil/trace.go:171","msg":"trace[881349508] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"119.051685ms","start":"2026-02-17T06:36:35.900974Z","end":"2026-02-17T06:36:36.020025Z","steps":["trace[881349508] 'process raft request' (duration: 118.703787ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:36.398032Z","caller":"traceutil/trace.go:171","msg":"trace[1006127717] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"370.271952ms","start":"2026-02-17T06:36:36.025102Z","end":"2026-02-17T06:36:36.395374Z","steps":["trace[1006127717] 'process raft request' (duration: 327.065607ms)","trace[1006127717] 'compare' (duration: 42.61121ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:36.398278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:36.025085Z","time spent":"373.069141ms","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:37:00.037386Z","caller":"traceutil/trace.go:171","msg":"trace[186748829] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"215.043657ms","start":"2026-02-17T06:36:59.822315Z","end":"2026-02-17T06:37:00.037359Z","steps":["trace[186748829] 'process raft request' (duration: 156.529276ms)","trace[186748829] 'compare' (duration: 58.315946ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:37:00.29034Z","caller":"traceutil/trace.go:171","msg":"trace[2010540866] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:792; }","duration":"159.391227ms","start":"2026-02-17T06:37:00.130912Z","end":"2026-02-17T06:37:00.290303Z","steps":["trace[2010540866] 'read index received' (duration: 63.148777ms)","trace[2010540866] 'applied index is now lower than readState.Index' (duration: 96.24149ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:37:00.290712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.741286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-17T06:37:00.2908Z","caller":"traceutil/trace.go:171","msg":"trace[1595646461] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:764; }","duration":"159.91577ms","start":"2026-02-17T06:37:00.130865Z","end":"2026-02-17T06:37:00.290781Z","steps":["trace[1595646461] 'agreement among raft nodes before linearized reading' (duration: 159.563561ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:00.29086Z","caller":"traceutil/trace.go:171","msg":"trace[1424131365] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"211.303363ms","start":"2026-02-17T06:37:00.079541Z","end":"2026-02-17T06:37:00.290844Z","steps":["trace[1424131365] 'process raft request' (duration: 114.587021ms)","trace[1424131365] 'compare' (duration: 96.008964ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:37:00.538618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.276866ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:37:00.538765Z","caller":"traceutil/trace.go:171","msg":"trace[1211238853] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"240.562558ms","start":"2026-02-17T06:37:00.298167Z","end":"2026-02-17T06:37:00.538729Z","steps":["trace[1211238853] 'process raft request' (duration: 111.904743ms)","trace[1211238853] 'compare' (duration: 128.121111ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:37:25.005181Z","caller":"traceutil/trace.go:171","msg":"trace[1521209452] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"132.680716ms","start":"2026-02-17T06:37:24.872482Z","end":"2026-02-17T06:37:25.005163Z","steps":["trace[1521209452] 'process raft request' (duration: 132.554872ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:25.005266Z","caller":"traceutil/trace.go:171","msg":"trace[239598729] linearizableReadLoop","detail":"{readStateIndex:920; appliedIndex:920; }","duration":"126.479511ms","start":"2026-02-17T06:37:24.878777Z","end":"2026-02-17T06:37:25.005257Z","steps":["trace[239598729] 'read index received' (duration: 126.47449ms)","trace[239598729] 'applied index is now lower than readState.Index' (duration: 4.271µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:37:25.0056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.805238ms","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-02-17T06:37:25.005701Z","caller":"traceutil/trace.go:171","msg":"trace[2118461765] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:885; }","duration":"126.941861ms","start":"2026-02-17T06:37:24.878752Z","end":"2026-02-17T06:37:25.005694Z","steps":["trace[2118461765] 'agreement among raft nodes before linearized reading' (duration: 126.531381ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:25.344206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.308135ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-17T06:37:25.344492Z","caller":"traceutil/trace.go:171","msg":"trace[186467444] linearizableReadLoop","detail":"{readStateIndex:922; appliedIndex:920; }","duration":"294.209477ms","start":"2026-02-17T06:37:25.050256Z","end":"2026-02-17T06:37:25.344465Z","steps":["trace[186467444] 'read index received' (duration: 148.882514ms)","trace[186467444] 'applied index is now lower than readState.Index' (duration: 145.325493ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:37:25.34458Z","caller":"traceutil/trace.go:171","msg":"trace[846849028] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"335.24965ms","start":"2026-02-17T06:37:25.009323Z","end":"2026-02-17T06:37:25.344572Z","steps":["trace[846849028] 'process raft request' (duration: 335.013624ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:25.344683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:25.009295Z","time spent":"335.305672ms","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:37:25.394824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.375941ms","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-02-17T06:37:25.394865Z","caller":"traceutil/trace.go:171","msg":"trace[1863942618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:886; }","duration":"208.423912ms","start":"2026-02-17T06:37:25.186428Z","end":"2026-02-17T06:37:25.394852Z","steps":["trace[1863942618] 'agreement among raft nodes before linearized reading' (duration: 158.414234ms)","trace[1863942618] 'range keys from in-memory index tree' (duration: 49.852793ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:37:25.395015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.758688ms","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-02-17T06:37:25.395032Z","caller":"traceutil/trace.go:171","msg":"trace[1124234180] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:886; }","duration":"344.80175ms","start":"2026-02-17T06:37:25.050224Z","end":"2026-02-17T06:37:25.395026Z","steps":["trace[1124234180] 'agreement among raft nodes before linearized reading' (duration: 294.587698ms)","trace[1124234180] 'range keys from in-memory index tree' (duration: 50.163441ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:37:25.395047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:25.050208Z","time spent":"344.83355ms","remote":"127.0.0.1:33074","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-02-17T06:37:25.395698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.883819ms","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-02-17T06:37:25.395723Z","caller":"traceutil/trace.go:171","msg":"trace[1028742208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:886; }","duration":"215.942539ms","start":"2026-02-17T06:37:25.179775Z","end":"2026-02-17T06:37:25.395718Z","steps":["trace[1028742208] 'agreement among raft nodes before linearized reading' (duration: 165.05344ms)","trace[1028742208] 'range keys from in-memory index tree' (duration: 50.269024ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:37:33.214222Z","caller":"traceutil/trace.go:171","msg":"trace[711625863] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"159.999613ms","start":"2026-02-17T06:37:33.054197Z","end":"2026-02-17T06:37:33.214197Z","steps":["trace[711625863] 'process raft request' (duration: 159.903281ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:33.930309Z","caller":"traceutil/trace.go:171","msg":"trace[582891688] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"120.346096ms","start":"2026-02-17T06:37:33.809948Z","end":"2026-02-17T06:37:33.930294Z","steps":["trace[582891688] 'process raft request' (duration: 120.245414ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:35.454286Z","caller":"traceutil/trace.go:171","msg":"trace[618238262] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"232.406215ms","start":"2026-02-17T06:37:35.221856Z","end":"2026-02-17T06:37:35.454262Z","steps":["trace[618238262] 'process raft request' (duration: 232.106936ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:35.791516Z","caller":"traceutil/trace.go:171","msg":"trace[2005002103] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"243.020871ms","start":"2026-02-17T06:37:35.548444Z","end":"2026-02-17T06:37:35.791465Z","steps":["trace[2005002103] 'process raft request' (duration: 242.826096ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:35.988259Z","caller":"traceutil/trace.go:171","msg":"trace[1180018033] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"434.093106ms","start":"2026-02-17T06:37:35.554118Z","end":"2026-02-17T06:37:35.988211Z","steps":["trace[1180018033] 'process raft request' (duration: 434.020224ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:35.988305Z","caller":"traceutil/trace.go:171","msg":"trace[418254510] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"436.285721ms","start":"2026-02-17T06:37:35.551993Z","end":"2026-02-17T06:37:35.988278Z","steps":["trace[418254510] 'process raft request' (duration: 369.319697ms)","trace[418254510] 'compare' (duration: 66.617175ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:37:35.988381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:35.554111Z","time spent":"434.207739ms","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:37:35.988442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:35.551983Z","time spent":"436.389224ms","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:37:50.022813Z","caller":"traceutil/trace.go:171","msg":"trace[262115305] linearizableReadLoop","detail":"{readStateIndex:1056; appliedIndex:1055; }","duration":"168.790744ms","start":"2026-02-17T06:37:49.853994Z","end":"2026-02-17T06:37:50.022785Z","steps":["trace[262115305] 'read index received' (duration: 168.560149ms)","trace[262115305] 'applied index is now lower than readState.Index' (duration: 228.975µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:37:50.02312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.082252ms","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-02-17T06:37:50.023153Z","caller":"traceutil/trace.go:171","msg":"trace[104803496] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1015; }","duration":"169.213275ms","start":"2026-02-17T06:37:49.853929Z","end":"2026-02-17T06:37:50.023142Z","steps":["trace[104803496] 'agreement among raft nodes before linearized reading' (duration: 168.992349ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:50.231773Z","caller":"traceutil/trace.go:171","msg":"trace[79869704] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"206.362509ms","start":"2026-02-17T06:37:50.025353Z","end":"2026-02-17T06:37:50.231715Z","steps":["trace[79869704] 'process raft request' (duration: 179.904804ms)","trace[79869704] 'compare' (duration: 25.49654ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:37:50.231926Z","caller":"traceutil/trace.go:171","msg":"trace[873910914] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"202.905273ms","start":"2026-02-17T06:37:50.028989Z","end":"2026-02-17T06:37:50.231894Z","steps":["trace[873910914] 'process raft request' (duration: 202.573834ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:50.232188Z","caller":"traceutil/trace.go:171","msg":"trace[1620082625] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"202.677096ms","start":"2026-02-17T06:37:50.029499Z","end":"2026-02-17T06:37:50.232176Z","steps":["trace[1620082625] 'process raft request' (duration: 202.146544ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:12.943929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.090473ms","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-02-17T06:39:12.944206Z","caller":"traceutil/trace.go:171","msg":"trace[1021640463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1355; }","duration":"233.454192ms","start":"2026-02-17T06:39:12.710727Z","end":"2026-02-17T06:39:12.944181Z","steps":["trace[1021640463] 'range keys from in-memory index tree' (duration: 232.644881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:12.945074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.006901ms","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-02-17T06:39:12.945155Z","caller":"traceutil/trace.go:171","msg":"trace[1063638716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1355; }","duration":"233.151794ms","start":"2026-02-17T06:39:12.71199Z","end":"2026-02-17T06:39:12.945141Z","steps":["trace[1063638716] 'range keys from in-memory index tree' (duration: 232.794056ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:39:13.285656Z","caller":"traceutil/trace.go:171","msg":"trace[2089239756] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"332.888116ms","start":"2026-02-17T06:39:12.952546Z","end":"2026-02-17T06:39:13.285434Z","steps":["trace[2089239756] 'process raft request' (duration: 332.427044ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:13.285927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:12.952526Z","time spent":"333.231105ms","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:39:13.801945Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313093953901954106,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:39:14.306003Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313093953901954106,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:39:14.806407Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313093953901954106,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:39:15.842475Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313093953901954106,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:39:15.842607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.266612587s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-17T06:39:15.844107Z","caller":"traceutil/trace.go:171","msg":"trace[1776736261] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.268169857s","start":"2026-02-17T06:39:13.575917Z","end":"2026-02-17T06:39:15.844087Z","steps":["trace[1776736261] 'agreement among raft nodes before linearized reading' (duration: 2.266665118s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:15.847916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:13.575804Z","time spent":"2.272085838s","remote":"127.0.0.1:32830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/17 06:39:15 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T06:39:16.3067Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.021871882s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T06:39:16.310841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.514081231s","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-02-17T06:39:16.313379Z","caller":"traceutil/trace.go:171","msg":"trace[1171020934] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1356; }","duration":"2.516846123s","start":"2026-02-17T06:39:13.796465Z","end":"2026-02-17T06:39:16.313311Z","steps":["trace[1171020934] 'range keys from in-memory index tree' (duration: 2.514065681s)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:39:16.316496Z","caller":"traceutil/trace.go:171","msg":"trace[1645040697] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"3.362638921s","start":"2026-02-17T06:39:12.953837Z","end":"2026-02-17T06:39:16.316476Z","steps":["trace[1645040697] 'process raft request' (duration: 3.355586719s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.316613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:12.95383Z","time spent":"3.362719932s","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:39:16.32192Z","caller":"traceutil/trace.go:171","msg":"trace[2048973406] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"2.248228883s","start":"2026-02-17T06:39:14.073605Z","end":"2026-02-17T06:39:16.321834Z","steps":["trace[2048973406] 'process raft request' (duration: 2.242613178s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.322121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:14.073573Z","time spent":"2.248432448s","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:39:16.360226Z","caller":"traceutil/trace.go:171","msg":"trace[1814253601] linearizableReadLoop","detail":"{readStateIndex:1415; appliedIndex:1413; }","duration":"3.059610445s","start":"2026-02-17T06:39:13.300598Z","end":"2026-02-17T06:39:16.360208Z","steps":["trace[1814253601] 'read index received' (duration: 3.008710893s)","trace[1814253601] 'applied index is now lower than readState.Index' (duration: 50.898772ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:39:16.360404Z","caller":"traceutil/trace.go:171","msg":"trace[1868174979] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"515.710464ms","start":"2026-02-17T06:39:15.844678Z","end":"2026-02-17T06:39:16.360389Z","steps":["trace[1868174979] 'process raft request' (duration: 515.070247ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.360485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:15.84467Z","time spent":"515.754705ms","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:39:16.360665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.060073537s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-02-17T06:39:16.360692Z","caller":"traceutil/trace.go:171","msg":"trace[1417008451] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1359; }","duration":"3.060190099s","start":"2026-02-17T06:39:13.300494Z","end":"2026-02-17T06:39:16.360685Z","steps":["trace[1417008451] 'agreement among raft nodes before linearized reading' (duration: 3.060100567s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.360711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:13.300474Z","time spent":"3.06023202s","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-17T06:39:16.36083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.011298491s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-17T06:39:16.360847Z","caller":"traceutil/trace.go:171","msg":"trace[2122810595] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1359; }","duration":"3.011363763s","start":"2026-02-17T06:39:13.349478Z","end":"2026-02-17T06:39:16.360842Z","steps":["trace[2122810595] 'agreement among raft nodes before linearized reading' (duration: 3.011308622s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.360865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:13.349453Z","time spent":"3.011407703s","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-02-17T06:39:16.361105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.858613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:39:16.361124Z","caller":"traceutil/trace.go:171","msg":"trace[1418037965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1359; }","duration":"509.907854ms","start":"2026-02-17T06:39:15.85121Z","end":"2026-02-17T06:39:16.361118Z","steps":["trace[1418037965] 'agreement among raft nodes before linearized reading' (duration: 509.878353ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.361139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:15.851204Z","time spent":"509.931814ms","remote":"127.0.0.1:32830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T06:39:16.361275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.131957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-17T06:39:16.363146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.490649138s","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-02-17T06:39:16.363182Z","caller":"traceutil/trace.go:171","msg":"trace[1477198796] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1359; }","duration":"2.490752511s","start":"2026-02-17T06:39:13.872422Z","end":"2026-02-17T06:39:16.363175Z","steps":["trace[1477198796] 'agreement among raft nodes before linearized reading' (duration: 2.490666149s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.363331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:13.872391Z","time spent":"2.490931746s","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T06:39:16.36355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.897817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T06:39:16.363575Z","caller":"traceutil/trace.go:171","msg":"trace[723616443] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1359; }","duration":"518.935618ms","start":"2026-02-17T06:39:15.844633Z","end":"2026-02-17T06:39:16.363569Z","steps":["trace[723616443] 'agreement among raft nodes before linearized reading' (duration: 518.884586ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.36374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:15.844631Z","time spent":"519.096971ms","remote":"127.0.0.1:33156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":31,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-17T06:39:16.363986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.356949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-02-17T06:39:16.364014Z","caller":"traceutil/trace.go:171","msg":"trace[1923478490] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1359; }","duration":"519.389969ms","start":"2026-02-17T06:39:15.844615Z","end":"2026-02-17T06:39:16.364005Z","steps":["trace[1923478490] 'agreement among raft nodes before linearized reading' (duration: 519.318217ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.364033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:15.844613Z","time spent":"519.41586ms","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":560,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-17T06:39:16.364354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.751299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:39:16.36438Z","caller":"traceutil/trace.go:171","msg":"trace[1470668286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1359; }","duration":"519.79919ms","start":"2026-02-17T06:39:15.844574Z","end":"2026-02-17T06:39:16.364374Z","steps":["trace[1470668286] 'agreement among raft nodes before linearized reading' (duration: 519.756169ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.364397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:15.844561Z","time spent":"519.832261ms","remote":"127.0.0.1:32824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T06:39:16.364617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.747449095s","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-02-17T06:39:16.364717Z","caller":"traceutil/trace.go:171","msg":"trace[272179975] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1359; }","duration":"1.747596628s","start":"2026-02-17T06:39:14.617113Z","end":"2026-02-17T06:39:16.36471Z","steps":["trace[272179975] 'agreement among raft nodes before linearized reading' (duration: 1.747452505s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.364738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:14.617091Z","time spent":"1.747641429s","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T06:39:16.364852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.375301207s","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-02-17T06:39:16.364869Z","caller":"traceutil/trace.go:171","msg":"trace[1657226389] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1359; }","duration":"2.375363968s","start":"2026-02-17T06:39:13.9895Z","end":"2026-02-17T06:39:16.364864Z","steps":["trace[1657226389] 'agreement among raft nodes before linearized reading' (duration: 2.375311087s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.364884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:13.989476Z","time spent":"2.37540411s","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-17T06:39:16.3613Z","caller":"traceutil/trace.go:171","msg":"trace[1195449860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1359; }","duration":"513.158878ms","start":"2026-02-17T06:39:15.848136Z","end":"2026-02-17T06:39:16.361295Z","steps":["trace[1195449860] 'agreement among raft nodes before linearized reading' (duration: 513.078796ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:16.367768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:39:15.848128Z","time spent":"519.623146ms","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}