{"level":"warn","ts":"2026-02-17T15:35:39.271535Z","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-17T15:35:39.271708Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.110: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.110:2380","--initial-cluster=instance=https://162.253.55.110:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.110:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.110: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-17T15:35:39.2718Z","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-17T15:35:39.271875Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-02-17T15:35:39.2719Z","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-17T15:35:39.274411Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"]} {"level":"info","ts":"2026-02-17T15:35:39.274635Z","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://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.110: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-17T15:35:39.284935Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.57084ms"} {"level":"info","ts":"2026-02-17T15:35:39.298612Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f52f30d5714009d5","cluster-id":"650981a7a383c714"} {"level":"info","ts":"2026-02-17T15:35:39.298797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T15:35:39.298849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 0"} {"level":"info","ts":"2026-02-17T15:35:39.298922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f52f30d5714009d5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T15:35:39.298934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 1"} {"level":"info","ts":"2026-02-17T15:35:39.29902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"warn","ts":"2026-02-17T15:35:39.308227Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T15:35:39.310613Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T15:35:39.314686Z","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-17T15:35:39.3205Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f52f30d5714009d5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T15:35:39.324712Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f52f30d5714009d5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T15:35:39.325934Z","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-17T15:35:39.325997Z","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-17T15:35:39.326226Z","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-17T15:35:39.327098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"info","ts":"2026-02-17T15:35:39.329778Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","added-peer-id":"f52f30d5714009d5","added-peer-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-02-17T15:35:39.340824Z","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-17T15:35:39.342448Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-02-17T15:35:39.34257Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-02-17T15:35:39.344638Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f52f30d5714009d5","initial-advertise-peer-urls":["https://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T15:35:39.344681Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T15:35:39.800127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T15:35:39.800223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T15:35:39.800256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgPreVoteResp from f52f30d5714009d5 at term 1"} {"level":"info","ts":"2026-02-17T15:35:39.800276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became candidate at term 2"} {"level":"info","ts":"2026-02-17T15:35:39.800308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgVoteResp from f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-02-17T15:35:39.800334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became leader at term 2"} {"level":"info","ts":"2026-02-17T15:35:39.800351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f52f30d5714009d5 elected leader f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-02-17T15:35:41.007262Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T15:35:41.417809Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f52f30d5714009d5","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.110:2379]}","request-path":"/0/members/f52f30d5714009d5/attributes","cluster-id":"650981a7a383c714","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T15:35:41.417877Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T15:35:41.41909Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T15:35:41.42131Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T15:35:41.4214Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T15:35:41.421423Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T15:35:41.421452Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T15:35:41.421465Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T15:35:41.423249Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.110:2379"} {"level":"info","ts":"2026-02-17T15:35:41.424021Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T15:35:51.907419Z","caller":"traceutil/trace.go:171","msg":"trace[1377426725] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"113.476516ms","start":"2026-02-17T15:35:51.793926Z","end":"2026-02-17T15:35:51.907402Z","steps":["trace[1377426725] 'process raft request' (duration: 106.252122ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:10.429142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.679561ms","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-17T15:36:10.429211Z","caller":"traceutil/trace.go:171","msg":"trace[1633818665] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:508; }","duration":"215.792474ms","start":"2026-02-17T15:36:10.213407Z","end":"2026-02-17T15:36:10.429199Z","steps":["trace[1633818665] 'range keys from in-memory index tree' (duration: 215.540837ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:14.218787Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708644505094072211,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T15:36:14.275824Z","caller":"traceutil/trace.go:171","msg":"trace[1209670650] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"962.240901ms","start":"2026-02-17T15:36:13.313555Z","end":"2026-02-17T15:36:14.275796Z","steps":["trace[1209670650] 'process raft request' (duration: 962.101837ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:14.277462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:13.313538Z","time spent":"962.362555ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T15:36:14.484199Z","caller":"traceutil/trace.go:171","msg":"trace[1577250924] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"1.067942789s","start":"2026-02-17T15:36:13.416239Z","end":"2026-02-17T15:36:14.484182Z","steps":["trace[1577250924] 'process raft request' (duration: 1.067782745s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:14.484421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:13.416221Z","time spent":"1.068023821s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T15:36:14.484634Z","caller":"traceutil/trace.go:171","msg":"trace[1009972847] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:571; }","duration":"766.213929ms","start":"2026-02-17T15:36:13.718411Z","end":"2026-02-17T15:36:14.484624Z","steps":["trace[1009972847] 'read index received' (duration: 557.747283ms)","trace[1009972847] 'applied index is now lower than readState.Index' (duration: 208.466036ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T15:36:14.484843Z","caller":"traceutil/trace.go:171","msg":"trace[704929424] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"967.095803ms","start":"2026-02-17T15:36:13.51774Z","end":"2026-02-17T15:36:14.484836Z","steps":["trace[704929424] 'process raft request' (duration: 966.398884ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:14.484875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:13.517716Z","time spent":"967.142334ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T15:36:14.48506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.646761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:14.485099Z","caller":"traceutil/trace.go:171","msg":"trace[986183022] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:553; }","duration":"766.719903ms","start":"2026-02-17T15:36:13.718371Z","end":"2026-02-17T15:36:14.485091Z","steps":["trace[986183022] 'agreement among raft nodes before linearized reading' (duration: 766.668041ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:14.48512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:13.718356Z","time spent":"766.757064ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-17T15:36:14.488867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.727837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:14.488896Z","caller":"traceutil/trace.go:171","msg":"trace[1089737543] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:554; }","duration":"575.803199ms","start":"2026-02-17T15:36:13.913086Z","end":"2026-02-17T15:36:14.488889Z","steps":["trace[1089737543] 'agreement among raft nodes before linearized reading' (duration: 575.751857ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:14.488916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:13.913068Z","time spent":"575.843699ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-02-17T15:36:14.489055Z","caller":"traceutil/trace.go:171","msg":"trace[1453478433] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"204.764117ms","start":"2026-02-17T15:36:14.284284Z","end":"2026-02-17T15:36:14.489048Z","steps":["trace[1453478433] 'process raft request' (duration: 204.51026ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:14.489241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.115778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-17T15:36:14.489261Z","caller":"traceutil/trace.go:171","msg":"trace[1485784260] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:554; }","duration":"176.172179ms","start":"2026-02-17T15:36:14.313083Z","end":"2026-02-17T15:36:14.489255Z","steps":["trace[1485784260] 'agreement among raft nodes before linearized reading' (duration: 176.121128ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:14.489339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.890958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.110\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T15:36:14.489355Z","caller":"traceutil/trace.go:171","msg":"trace[2011563922] range","detail":"{range_begin:/registry/masterleases/162.253.55.110; range_end:; response_count:1; response_revision:554; }","duration":"205.935189ms","start":"2026-02-17T15:36:14.283415Z","end":"2026-02-17T15:36:14.48935Z","steps":["trace[2011563922] 'agreement among raft nodes before linearized reading' (duration: 205.907768ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:14.489456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.057413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-17T15:36:14.489473Z","caller":"traceutil/trace.go:171","msg":"trace[1357014908] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:554; }","duration":"377.113064ms","start":"2026-02-17T15:36:14.112355Z","end":"2026-02-17T15:36:14.489468Z","steps":["trace[1357014908] 'agreement among raft nodes before linearized reading' (duration: 377.079083ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:14.4895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:14.112336Z","time spent":"377.150216ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5609,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-02-17T15:36:14.489592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.875324ms","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-17T15:36:14.489611Z","caller":"traceutil/trace.go:171","msg":"trace[1507146373] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:554; }","duration":"504.923826ms","start":"2026-02-17T15:36:13.98468Z","end":"2026-02-17T15:36:14.489604Z","steps":["trace[1507146373] 'agreement among raft nodes before linearized reading' (duration: 504.892105ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:14.489627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:13.984662Z","time spent":"504.960556ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-17T15:36:15.893311Z","caller":"traceutil/trace.go:171","msg":"trace[961287493] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"348.250412ms","start":"2026-02-17T15:36:15.545017Z","end":"2026-02-17T15:36:15.893268Z","steps":["trace[961287493] 'process raft request' (duration: 347.946413ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:15.893546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:15.544985Z","time spent":"348.449547ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T15:36:16.478202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.201401ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T15:36:16.478436Z","caller":"traceutil/trace.go:171","msg":"trace[1728776124] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"461.016227ms","start":"2026-02-17T15:36:16.017408Z","end":"2026-02-17T15:36:16.478424Z","steps":["trace[1728776124] 'process raft request' (duration: 460.905034ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:16.478491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:16.017379Z","time spent":"461.082639ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T15:36:16.478494Z","caller":"traceutil/trace.go:171","msg":"trace[1711851375] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"679.520114ms","start":"2026-02-17T15:36:15.798953Z","end":"2026-02-17T15:36:16.478473Z","steps":["trace[1711851375] 'process raft request' (duration: 328.877171ms)","trace[1711851375] 'compare' (duration: 350.069518ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T15:36:16.478625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:15.798917Z","time spent":"679.642577ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T15:36:16.478679Z","caller":"traceutil/trace.go:171","msg":"trace[1429634915] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:585; }","duration":"565.113492ms","start":"2026-02-17T15:36:15.913558Z","end":"2026-02-17T15:36:16.478671Z","steps":["trace[1429634915] 'read index received' (duration: 214.446608ms)","trace[1429634915] 'applied index is now lower than readState.Index' (duration: 350.664534ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T15:36:16.47884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.281357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-02-17T15:36:16.478862Z","caller":"traceutil/trace.go:171","msg":"trace[1724057594] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:566; }","duration":"565.330808ms","start":"2026-02-17T15:36:15.913522Z","end":"2026-02-17T15:36:16.478853Z","steps":["trace[1724057594] 'agreement among raft nodes before linearized reading' (duration: 565.232526ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:16.478883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:15.913503Z","time spent":"565.375659ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10400,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-17T15:36:16.483925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.550437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:16.483956Z","caller":"traceutil/trace.go:171","msg":"trace[1029060579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:567; }","duration":"529.620609ms","start":"2026-02-17T15:36:15.954327Z","end":"2026-02-17T15:36:16.483948Z","steps":["trace[1029060579] 'agreement among raft nodes before linearized reading' (duration: 529.532546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:16.483976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:15.954281Z","time spent":"529.69042ms","remote":"127.0.0.1:50752","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-02-17T15:36:16.484502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.216326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-17T15:36:16.484525Z","caller":"traceutil/trace.go:171","msg":"trace[203673310] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:567; }","duration":"371.271837ms","start":"2026-02-17T15:36:16.113245Z","end":"2026-02-17T15:36:16.484517Z","steps":["trace[203673310] 'agreement among raft nodes before linearized reading' (duration: 371.188175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:16.484542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:16.11323Z","time spent":"371.307298ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24267,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"info","ts":"2026-02-17T15:36:17.281609Z","caller":"traceutil/trace.go:171","msg":"trace[1251000137] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"477.206401ms","start":"2026-02-17T15:36:16.804387Z","end":"2026-02-17T15:36:17.281593Z","steps":["trace[1251000137] 'process raft request' (duration: 475.853644ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:17.281723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:16.804371Z","time spent":"477.291793ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T15:36:17.281903Z","caller":"traceutil/trace.go:171","msg":"trace[909599686] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"358.237917ms","start":"2026-02-17T15:36:16.923659Z","end":"2026-02-17T15:36:17.281897Z","steps":["trace[909599686] 'read index received' (duration: 356.48511ms)","trace[909599686] 'applied index is now lower than readState.Index' (duration: 1.752107ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T15:36:17.282046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.313494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-17T15:36:17.282074Z","caller":"traceutil/trace.go:171","msg":"trace[1462184903] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:572; }","duration":"201.364585ms","start":"2026-02-17T15:36:17.080704Z","end":"2026-02-17T15:36:17.282069Z","steps":["trace[1462184903] 'agreement among raft nodes before linearized reading' (duration: 201.292904ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:17.282235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.760865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188486"} {"level":"info","ts":"2026-02-17T15:36:17.282252Z","caller":"traceutil/trace.go:171","msg":"trace[1410960996] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:572; }","duration":"154.801676ms","start":"2026-02-17T15:36:17.127445Z","end":"2026-02-17T15:36:17.282246Z","steps":["trace[1410960996] 'agreement among raft nodes before linearized reading' (duration: 154.723114ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:17.282441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.782491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-02-17T15:36:17.28246Z","caller":"traceutil/trace.go:171","msg":"trace[195438096] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:572; }","duration":"358.832263ms","start":"2026-02-17T15:36:16.92362Z","end":"2026-02-17T15:36:17.282453Z","steps":["trace[195438096] 'agreement among raft nodes before linearized reading' (duration: 358.326709ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:17.282475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:16.923603Z","time spent":"358.868714ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":188275,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-17T15:36:17.282497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.105852ms","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-17T15:36:17.282509Z","caller":"traceutil/trace.go:171","msg":"trace[994632727] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:572; }","duration":"181.229955ms","start":"2026-02-17T15:36:17.101275Z","end":"2026-02-17T15:36:17.282505Z","steps":["trace[994632727] 'agreement among raft nodes before linearized reading' (duration: 181.114972ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:17.282668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.677743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-17T15:36:17.282683Z","caller":"traceutil/trace.go:171","msg":"trace[790893956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:572; }","duration":"198.707144ms","start":"2026-02-17T15:36:17.083971Z","end":"2026-02-17T15:36:17.282678Z","steps":["trace[790893956] 'agreement among raft nodes before linearized reading' (duration: 198.679853ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:36:18.431622Z","caller":"traceutil/trace.go:171","msg":"trace[1427227268] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"180.586868ms","start":"2026-02-17T15:36:18.251014Z","end":"2026-02-17T15:36:18.431601Z","steps":["trace[1427227268] 'read index received' (duration: 180.408694ms)","trace[1427227268] 'applied index is now lower than readState.Index' (duration: 177.304µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T15:36:18.431741Z","caller":"traceutil/trace.go:171","msg":"trace[874789228] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"193.077044ms","start":"2026-02-17T15:36:18.238646Z","end":"2026-02-17T15:36:18.431723Z","steps":["trace[874789228] 'process raft request' (duration: 192.821537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:18.431965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.931178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:18.432006Z","caller":"traceutil/trace.go:171","msg":"trace[2019868831] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:577; }","duration":"181.01188ms","start":"2026-02-17T15:36:18.250982Z","end":"2026-02-17T15:36:18.431994Z","steps":["trace[2019868831] 'agreement among raft nodes before linearized reading' (duration: 180.939358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:18.43218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.103012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:18.432216Z","caller":"traceutil/trace.go:171","msg":"trace[1422017415] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:577; }","duration":"181.156504ms","start":"2026-02-17T15:36:18.251048Z","end":"2026-02-17T15:36:18.432204Z","steps":["trace[1422017415] 'agreement among raft nodes before linearized reading' (duration: 181.091922ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:18.432337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.483704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:18.432372Z","caller":"traceutil/trace.go:171","msg":"trace[270009938] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:577; }","duration":"130.529465ms","start":"2026-02-17T15:36:18.301833Z","end":"2026-02-17T15:36:18.432362Z","steps":["trace[270009938] 'agreement among raft nodes before linearized reading' (duration: 130.480173ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:18.432351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.265438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:18.436303Z","caller":"traceutil/trace.go:171","msg":"trace[1717488880] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:577; }","duration":"134.385878ms","start":"2026-02-17T15:36:18.3019Z","end":"2026-02-17T15:36:18.436286Z","steps":["trace[1717488880] 'agreement among raft nodes before linearized reading' (duration: 130.247337ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:18.4325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.572153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:18.43704Z","caller":"traceutil/trace.go:171","msg":"trace[1065981592] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:577; }","duration":"158.123835ms","start":"2026-02-17T15:36:18.278906Z","end":"2026-02-17T15:36:18.437029Z","steps":["trace[1065981592] 'agreement among raft nodes before linearized reading' (duration: 153.572683ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:18.432536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.635635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:18.437758Z","caller":"traceutil/trace.go:171","msg":"trace[340451893] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:577; }","duration":"158.864955ms","start":"2026-02-17T15:36:18.278884Z","end":"2026-02-17T15:36:18.437749Z","steps":["trace[340451893] 'agreement among raft nodes before linearized reading' (duration: 153.636855ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:18.432567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.770068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:18.43923Z","caller":"traceutil/trace.go:171","msg":"trace[1191783025] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:577; }","duration":"160.443978ms","start":"2026-02-17T15:36:18.278776Z","end":"2026-02-17T15:36:18.43922Z","steps":["trace[1191783025] 'agreement among raft nodes before linearized reading' (duration: 153.775789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:18.432601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.516774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:18.44001Z","caller":"traceutil/trace.go:171","msg":"trace[1997627182] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:577; }","duration":"188.945183ms","start":"2026-02-17T15:36:18.251054Z","end":"2026-02-17T15:36:18.439999Z","steps":["trace[1997627182] 'agreement among raft nodes before linearized reading' (duration: 181.526924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:18.432976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.959226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:18.440177Z","caller":"traceutil/trace.go:171","msg":"trace[1026346473] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:577; }","duration":"138.170489ms","start":"2026-02-17T15:36:18.301998Z","end":"2026-02-17T15:36:18.440169Z","steps":["trace[1026346473] 'agreement among raft nodes before linearized reading' (duration: 130.952136ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:36:23.007262Z","caller":"traceutil/trace.go:171","msg":"trace[953969996] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"411.16426ms","start":"2026-02-17T15:36:22.596074Z","end":"2026-02-17T15:36:23.007238Z","steps":["trace[953969996] 'read index received' (duration: 410.894163ms)","trace[953969996] 'applied index is now lower than readState.Index' (duration: 268.937µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T15:36:23.007529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.434958ms","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-17T15:36:23.007618Z","caller":"traceutil/trace.go:171","msg":"trace[1585348634] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"411.54679ms","start":"2026-02-17T15:36:22.596044Z","end":"2026-02-17T15:36:23.007591Z","steps":["trace[1585348634] 'agreement among raft nodes before linearized reading' (duration: 411.319484ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:23.007658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:22.59603Z","time spent":"411.618622ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T15:36:23.00769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.454299ms","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-17T15:36:23.007731Z","caller":"traceutil/trace.go:171","msg":"trace[2092119318] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:591; }","duration":"290.533931ms","start":"2026-02-17T15:36:22.717186Z","end":"2026-02-17T15:36:23.00772Z","steps":["trace[2092119318] 'agreement among raft nodes before linearized reading' (duration: 290.375207ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:36:23.007842Z","caller":"traceutil/trace.go:171","msg":"trace[469871897] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"942.797443ms","start":"2026-02-17T15:36:22.065033Z","end":"2026-02-17T15:36:23.00783Z","steps":["trace[469871897] 'process raft request' (duration: 942.013172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:23.007923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:22.065002Z","time spent":"942.866755ms","remote":"127.0.0.1:50964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T15:36:23.600557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.931956ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T15:36:23.60067Z","caller":"traceutil/trace.go:171","msg":"trace[1783938672] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:613; }","duration":"217.478018ms","start":"2026-02-17T15:36:23.38318Z","end":"2026-02-17T15:36:23.600658Z","steps":["trace[1783938672] 'read index received' (duration: 155.694219ms)","trace[1783938672] 'applied index is now lower than readState.Index' (duration: 61.783109ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T15:36:23.600822Z","caller":"traceutil/trace.go:171","msg":"trace[1991582449] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"587.311278ms","start":"2026-02-17T15:36:23.013501Z","end":"2026-02-17T15:36:23.600812Z","steps":["trace[1991582449] 'process raft request' (duration: 171.073303ms)","trace[1991582449] 'compare' (duration: 415.551416ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T15:36:23.600861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:23.013491Z","time spent":"587.348918ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T15:36:23.60096Z","caller":"traceutil/trace.go:171","msg":"trace[868763271] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"583.277879ms","start":"2026-02-17T15:36:23.017676Z","end":"2026-02-17T15:36:23.600954Z","steps":["trace[868763271] 'process raft request' (duration: 582.948401ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:23.600991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:23.017665Z","time spent":"583.30805ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T15:36:23.601108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.942121ms","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-17T15:36:23.601125Z","caller":"traceutil/trace.go:171","msg":"trace[1221271828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:593; }","duration":"217.987472ms","start":"2026-02-17T15:36:23.383132Z","end":"2026-02-17T15:36:23.60112Z","steps":["trace[1221271828] 'agreement among raft nodes before linearized reading' (duration: 217.91671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:23.60122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.338471ms","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-17T15:36:23.60124Z","caller":"traceutil/trace.go:171","msg":"trace[581407464] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"215.383092ms","start":"2026-02-17T15:36:23.385851Z","end":"2026-02-17T15:36:23.601234Z","steps":["trace[581407464] 'agreement among raft nodes before linearized reading' (duration: 215.336851ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:23.601401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.303693ms","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-17T15:36:23.601419Z","caller":"traceutil/trace.go:171","msg":"trace[1465130543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"214.349675ms","start":"2026-02-17T15:36:23.387064Z","end":"2026-02-17T15:36:23.601414Z","steps":["trace[1465130543] 'agreement among raft nodes before linearized reading' (duration: 214.282523ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:36:23.78951Z","caller":"traceutil/trace.go:171","msg":"trace[1925466788] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"177.897607ms","start":"2026-02-17T15:36:23.611574Z","end":"2026-02-17T15:36:23.789471Z","steps":["trace[1925466788] 'process raft request' (duration: 177.865726ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:36:23.791136Z","caller":"traceutil/trace.go:171","msg":"trace[1071610770] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"184.556826ms","start":"2026-02-17T15:36:23.606556Z","end":"2026-02-17T15:36:23.791113Z","steps":["trace[1071610770] 'process raft request' (duration: 152.515125ms)","trace[1071610770] 'compare' (duration: 30.064558ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T15:36:23.791313Z","caller":"traceutil/trace.go:171","msg":"trace[1265116775] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"182.559122ms","start":"2026-02-17T15:36:23.608743Z","end":"2026-02-17T15:36:23.791302Z","steps":["trace[1265116775] 'process raft request' (duration: 180.64761ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:36:37.865698Z","caller":"traceutil/trace.go:171","msg":"trace[13892986] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"156.359018ms","start":"2026-02-17T15:36:37.709292Z","end":"2026-02-17T15:36:37.865651Z","steps":["trace[13892986] 'process raft request' (duration: 155.947667ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:36:44.729947Z","caller":"traceutil/trace.go:171","msg":"trace[1357816381] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"384.281757ms","start":"2026-02-17T15:36:44.345646Z","end":"2026-02-17T15:36:44.729928Z","steps":["trace[1357816381] 'process raft request' (duration: 384.165714ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:44.730072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:36:44.345628Z","time spent":"384.37705ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T15:36:58.163095Z","caller":"traceutil/trace.go:171","msg":"trace[1358909151] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"188.126317ms","start":"2026-02-17T15:36:57.974948Z","end":"2026-02-17T15:36:58.163074Z","steps":["trace[1358909151] 'process raft request' (duration: 187.901391ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:36:58.179555Z","caller":"traceutil/trace.go:171","msg":"trace[934122138] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"200.909404ms","start":"2026-02-17T15:36:57.978626Z","end":"2026-02-17T15:36:58.179535Z","steps":["trace[934122138] 'process raft request' (duration: 200.870773ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:36:58.179919Z","caller":"traceutil/trace.go:171","msg":"trace[248891518] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"202.834476ms","start":"2026-02-17T15:36:57.977073Z","end":"2026-02-17T15:36:58.179907Z","steps":["trace[248891518] 'process raft request' (duration: 202.341143ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:36:59.879703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.745983ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T15:36:59.880595Z","caller":"traceutil/trace.go:171","msg":"trace[833524103] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:823; }","duration":"285.167156ms","start":"2026-02-17T15:36:59.595409Z","end":"2026-02-17T15:36:59.880576Z","steps":["trace[833524103] 'read index received' (duration: 37.981µs)","trace[833524103] 'applied index is now lower than readState.Index' (duration: 285.127205ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T15:36:59.880717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.292489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:36:59.880791Z","caller":"traceutil/trace.go:171","msg":"trace[1488151855] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:792; }","duration":"285.414923ms","start":"2026-02-17T15:36:59.595358Z","end":"2026-02-17T15:36:59.880773Z","steps":["trace[1488151855] 'agreement among raft nodes before linearized reading' (duration: 285.261549ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:00.065097Z","caller":"traceutil/trace.go:171","msg":"trace[768473429] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"110.843053ms","start":"2026-02-17T15:36:59.95424Z","end":"2026-02-17T15:37:00.065083Z","steps":["trace[768473429] 'read index received' (duration: 110.72887ms)","trace[768473429] 'applied index is now lower than readState.Index' (duration: 113.163µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T15:37:00.065272Z","caller":"traceutil/trace.go:171","msg":"trace[1577956866] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"111.426509ms","start":"2026-02-17T15:36:59.953836Z","end":"2026-02-17T15:37:00.065263Z","steps":["trace[1577956866] 'process raft request' (duration: 111.163622ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:00.065381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.127941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:37:00.066898Z","caller":"traceutil/trace.go:171","msg":"trace[241187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:793; }","duration":"111.169962ms","start":"2026-02-17T15:36:59.954226Z","end":"2026-02-17T15:37:00.065396Z","steps":["trace[241187] 'agreement among raft nodes before linearized reading' (duration: 111.127851ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:12.301224Z","caller":"traceutil/trace.go:171","msg":"trace[1507372622] linearizableReadLoop","detail":"{readStateIndex:913; appliedIndex:912; }","duration":"101.986153ms","start":"2026-02-17T15:37:12.199208Z","end":"2026-02-17T15:37:12.301194Z","steps":["trace[1507372622] 'read index received' (duration: 101.8562ms)","trace[1507372622] 'applied index is now lower than readState.Index' (duration: 129.393µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T15:37:12.301545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.324913ms","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-17T15:37:12.301576Z","caller":"traceutil/trace.go:171","msg":"trace[449417499] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:877; }","duration":"102.398875ms","start":"2026-02-17T15:37:12.19917Z","end":"2026-02-17T15:37:12.301569Z","steps":["trace[449417499] 'agreement among raft nodes before linearized reading' (duration: 102.21248ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:12.302167Z","caller":"traceutil/trace.go:171","msg":"trace[1240826183] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"181.203338ms","start":"2026-02-17T15:37:12.120933Z","end":"2026-02-17T15:37:12.302136Z","steps":["trace[1240826183] 'process raft request' (duration: 180.16595ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:22.486399Z","caller":"traceutil/trace.go:171","msg":"trace[2143293001] linearizableReadLoop","detail":"{readStateIndex:943; appliedIndex:942; }","duration":"109.646803ms","start":"2026-02-17T15:37:22.376731Z","end":"2026-02-17T15:37:22.486377Z","steps":["trace[2143293001] 'read index received' (duration: 109.470558ms)","trace[2143293001] 'applied index is now lower than readState.Index' (duration: 175.315µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T15:37:22.486586Z","caller":"traceutil/trace.go:171","msg":"trace[2024075035] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"134.860638ms","start":"2026-02-17T15:37:22.351719Z","end":"2026-02-17T15:37:22.48658Z","steps":["trace[2024075035] 'process raft request' (duration: 134.54351ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:22.486815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.071894ms","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-17T15:37:22.486834Z","caller":"traceutil/trace.go:171","msg":"trace[1968798193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:905; }","duration":"110.113875ms","start":"2026-02-17T15:37:22.376714Z","end":"2026-02-17T15:37:22.486828Z","steps":["trace[1968798193] 'agreement among raft nodes before linearized reading' (duration: 110.001372ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:22.486922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.919946ms","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-17T15:37:22.486934Z","caller":"traceutil/trace.go:171","msg":"trace[1123013760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:905; }","duration":"107.972057ms","start":"2026-02-17T15:37:22.378958Z","end":"2026-02-17T15:37:22.48693Z","steps":["trace[1123013760] 'agreement among raft nodes before linearized reading' (duration: 107.935196ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:22.487039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.242624ms","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-17T15:37:22.487052Z","caller":"traceutil/trace.go:171","msg":"trace[1231023202] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:905; }","duration":"101.258904ms","start":"2026-02-17T15:37:22.385789Z","end":"2026-02-17T15:37:22.487048Z","steps":["trace[1231023202] 'agreement among raft nodes before linearized reading' (duration: 101.217503ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:22.487153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.533268ms","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-17T15:37:22.487167Z","caller":"traceutil/trace.go:171","msg":"trace[1803180423] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:905; }","duration":"106.580029ms","start":"2026-02-17T15:37:22.380582Z","end":"2026-02-17T15:37:22.487162Z","steps":["trace[1803180423] 'agreement among raft nodes before linearized reading' (duration: 106.517058ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:22.595822Z","caller":"traceutil/trace.go:171","msg":"trace[854346012] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"101.036618ms","start":"2026-02-17T15:37:22.494763Z","end":"2026-02-17T15:37:22.5958Z","steps":["trace[854346012] 'process raft request' (duration: 101.003447ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:22.596078Z","caller":"traceutil/trace.go:171","msg":"trace[197683187] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"102.511028ms","start":"2026-02-17T15:37:22.493557Z","end":"2026-02-17T15:37:22.596068Z","steps":["trace[197683187] 'process raft request' (duration: 102.138708ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:22.596159Z","caller":"traceutil/trace.go:171","msg":"trace[870988698] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"102.516248ms","start":"2026-02-17T15:37:22.493636Z","end":"2026-02-17T15:37:22.596152Z","steps":["trace[870988698] 'process raft request' (duration: 102.106217ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:34.791012Z","caller":"traceutil/trace.go:171","msg":"trace[1961305508] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"103.830954ms","start":"2026-02-17T15:37:34.687161Z","end":"2026-02-17T15:37:34.790992Z","steps":["trace[1961305508] 'process raft request' (duration: 103.534886ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:34.978935Z","caller":"traceutil/trace.go:171","msg":"trace[850566318] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"177.044425ms","start":"2026-02-17T15:37:34.801875Z","end":"2026-02-17T15:37:34.97892Z","steps":["trace[850566318] 'process raft request' (duration: 177.013495ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:34.979133Z","caller":"traceutil/trace.go:171","msg":"trace[1683516169] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"179.606635ms","start":"2026-02-17T15:37:34.799519Z","end":"2026-02-17T15:37:34.979125Z","steps":["trace[1683516169] 'process raft request' (duration: 154.729228ms)","trace[1683516169] 'compare' (duration: 24.356993ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T15:37:34.979215Z","caller":"traceutil/trace.go:171","msg":"trace[1441767105] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"179.504812ms","start":"2026-02-17T15:37:34.799706Z","end":"2026-02-17T15:37:34.979211Z","steps":["trace[1441767105] 'process raft request' (duration: 179.134952ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:34.979251Z","caller":"traceutil/trace.go:171","msg":"trace[643949238] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"177.691322ms","start":"2026-02-17T15:37:34.801556Z","end":"2026-02-17T15:37:34.979247Z","steps":["trace[643949238] 'process raft request' (duration: 177.310162ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:44.415629Z","caller":"traceutil/trace.go:171","msg":"trace[162923747] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"110.293ms","start":"2026-02-17T15:37:44.305307Z","end":"2026-02-17T15:37:44.4156Z","steps":["trace[162923747] 'process raft request' (duration: 109.337444ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:37:48.636843Z","caller":"traceutil/trace.go:171","msg":"trace[1276567994] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"164.387871ms","start":"2026-02-17T15:37:48.472437Z","end":"2026-02-17T15:37:48.636825Z","steps":["trace[1276567994] 'process raft request' (duration: 164.266027ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:48.866196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.638316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T15:37:48.866299Z","caller":"traceutil/trace.go:171","msg":"trace[1213105891] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"221.319609ms","start":"2026-02-17T15:37:48.644961Z","end":"2026-02-17T15:37:48.86628Z","steps":["trace[1213105891] 'process raft request' (duration: 116.488168ms)","trace[1213105891] 'compare' (duration: 104.512923ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T15:37:49.428758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.695561ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T15:37:49.429313Z","caller":"traceutil/trace.go:171","msg":"trace[1864407398] linearizableReadLoop","detail":"{readStateIndex:1083; appliedIndex:1080; }","duration":"556.838994ms","start":"2026-02-17T15:37:48.872456Z","end":"2026-02-17T15:37:49.429295Z","steps":["trace[1864407398] 'read index received' (duration: 274.523546ms)","trace[1864407398] 'applied index is now lower than readState.Index' (duration: 282.314418ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T15:37:49.42931Z","caller":"traceutil/trace.go:171","msg":"trace[1885396263] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"782.548654ms","start":"2026-02-17T15:37:48.646727Z","end":"2026-02-17T15:37:49.429276Z","steps":["trace[1885396263] 'process raft request' (duration: 500.245726ms)","trace[1885396263] 'compare' (duration: 281.584428ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T15:37:49.429632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:37:48.646708Z","time spent":"782.757799ms","remote":"127.0.0.1:50948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":928,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T15:37:49.430542Z","caller":"traceutil/trace.go:171","msg":"trace[73084822] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"782.583585ms","start":"2026-02-17T15:37:48.647943Z","end":"2026-02-17T15:37:49.430527Z","steps":["trace[73084822] 'process raft request' (duration: 780.904929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:49.430819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:37:48.647935Z","time spent":"782.837982ms","remote":"127.0.0.1:51250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10772,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T15:37:49.431369Z","caller":"traceutil/trace.go:171","msg":"trace[1112016202] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"626.414287ms","start":"2026-02-17T15:37:48.804941Z","end":"2026-02-17T15:37:49.431355Z","steps":["trace[1112016202] 'process raft request' (duration: 624.30765ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:49.4315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:37:48.804914Z","time spent":"626.54662ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T15:37:49.432257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.793935ms","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-17T15:37:49.432449Z","caller":"traceutil/trace.go:171","msg":"trace[1547774282] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1040; }","duration":"560.056632ms","start":"2026-02-17T15:37:48.872377Z","end":"2026-02-17T15:37:49.432433Z","steps":["trace[1547774282] 'agreement among raft nodes before linearized reading' (duration: 559.726943ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:49.432611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:37:48.872357Z","time spent":"560.240537ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T15:37:49.432481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.575952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T15:37:49.433025Z","caller":"traceutil/trace.go:171","msg":"trace[1889023297] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1040; }","duration":"527.103176ms","start":"2026-02-17T15:37:48.905859Z","end":"2026-02-17T15:37:49.432962Z","steps":["trace[1889023297] 'agreement among raft nodes before linearized reading' (duration: 526.584072ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:49.433409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:37:48.905843Z","time spent":"527.27167ms","remote":"127.0.0.1:51032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-02-17T15:37:49.433838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.907808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-02-17T15:37:49.433879Z","caller":"traceutil/trace.go:171","msg":"trace[644747658] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1040; }","duration":"347.123291ms","start":"2026-02-17T15:37:49.086741Z","end":"2026-02-17T15:37:49.433865Z","steps":["trace[644747658] 'agreement among raft nodes before linearized reading' (duration: 345.828035ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:49.434278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:37:49.086734Z","time spent":"347.532513ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-17T15:37:49.43444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.58095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-17T15:37:49.434538Z","caller":"traceutil/trace.go:171","msg":"trace[1779516347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1040; }","duration":"359.681543ms","start":"2026-02-17T15:37:49.074844Z","end":"2026-02-17T15:37:49.434526Z","steps":["trace[1779516347] 'agreement among raft nodes before linearized reading' (duration: 359.393815ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:49.434678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:37:49.074811Z","time spent":"359.855317ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T15:37:49.434948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.549444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-17T15:37:49.435067Z","caller":"traceutil/trace.go:171","msg":"trace[453327457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1040; }","duration":"350.653657ms","start":"2026-02-17T15:37:49.084376Z","end":"2026-02-17T15:37:49.43503Z","steps":["trace[453327457] 'agreement among raft nodes before linearized reading' (duration: 350.456162ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:49.43565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:37:49.084369Z","time spent":"351.269954ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T15:37:49.435383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.167752ms","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-02-17T15:37:49.435995Z","caller":"traceutil/trace.go:171","msg":"trace[316447363] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1040; }","duration":"365.815149ms","start":"2026-02-17T15:37:49.070165Z","end":"2026-02-17T15:37:49.43598Z","steps":["trace[316447363] 'agreement among raft nodes before linearized reading' (duration: 365.12755ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:49.436842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:37:49.070147Z","time spent":"366.678352ms","remote":"127.0.0.1:51048","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":"warn","ts":"2026-02-17T15:37:49.435491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.386486ms","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-17T15:37:49.437299Z","caller":"traceutil/trace.go:171","msg":"trace[214363634] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1040; }","duration":"364.227936ms","start":"2026-02-17T15:37:49.073057Z","end":"2026-02-17T15:37:49.437285Z","steps":["trace[214363634] 'agreement among raft nodes before linearized reading' (duration: 362.350935ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:37:49.437461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:37:49.073018Z","time spent":"364.429021ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-17T15:38:31.906565Z","caller":"traceutil/trace.go:171","msg":"trace[320417446] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"124.578396ms","start":"2026-02-17T15:38:31.78197Z","end":"2026-02-17T15:38:31.906548Z","steps":["trace[320417446] 'process raft request' (duration: 43.303813ms)","trace[320417446] 'compare' (duration: 81.026446ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T15:38:31.907627Z","caller":"traceutil/trace.go:171","msg":"trace[661066677] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"117.992908ms","start":"2026-02-17T15:38:31.789625Z","end":"2026-02-17T15:38:31.907618Z","steps":["trace[661066677] 'read index received' (duration: 35.601645ms)","trace[661066677] 'applied index is now lower than readState.Index' (duration: 82.390503ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T15:38:31.908235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.084975ms","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-17T15:38:31.908384Z","caller":"traceutil/trace.go:171","msg":"trace[1527510060] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1218; }","duration":"123.23584ms","start":"2026-02-17T15:38:31.785119Z","end":"2026-02-17T15:38:31.908355Z","steps":["trace[1527510060] 'agreement among raft nodes before linearized reading' (duration: 123.028684ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:38:31.97451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.676984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T15:38:31.974825Z","caller":"traceutil/trace.go:171","msg":"trace[1028273002] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1219; }","duration":"144.035273ms","start":"2026-02-17T15:38:31.830773Z","end":"2026-02-17T15:38:31.974808Z","steps":["trace[1028273002] 'agreement among raft nodes before linearized reading' (duration: 143.691024ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:38:38.59129Z","caller":"traceutil/trace.go:171","msg":"trace[1415491814] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"156.286965ms","start":"2026-02-17T15:38:38.433983Z","end":"2026-02-17T15:38:38.59027Z","steps":["trace[1415491814] 'process raft request' (duration: 156.066449ms)"],"step_count":1}