{"level":"warn","ts":"2026-02-16T22:58:09.959431Z","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-16T22:58:09.959599Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.233: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.233:2380","--initial-cluster=instance=https://199.204.45.233:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.233:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.233: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-16T22:58:09.959696Z","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-16T22:58:09.959707Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-02-16T22:58:09.959733Z","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-16T22:58:09.960545Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"]} {"level":"info","ts":"2026-02-16T22:58:09.963597Z","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.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.233: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-16T22:58:09.970944Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.005842ms"} {"level":"info","ts":"2026-02-16T22:58:10.012959Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"90a0cb2044183f95","cluster-id":"782fef34d5ea94f9"} {"level":"info","ts":"2026-02-16T22:58:10.013202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=()"} {"level":"info","ts":"2026-02-16T22:58:10.01329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 0"} {"level":"info","ts":"2026-02-16T22:58:10.013308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 90a0cb2044183f95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-16T22:58:10.01337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 1"} {"level":"info","ts":"2026-02-16T22:58:10.013445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"warn","ts":"2026-02-16T22:58:10.02981Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-16T22:58:10.034096Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-16T22:58:10.037905Z","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-16T22:58:10.0431Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"90a0cb2044183f95","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-16T22:58:10.04342Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"90a0cb2044183f95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-16T22:58:10.049816Z","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-16T22:58:10.05938Z","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-16T22:58:10.059397Z","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-16T22:58:10.057006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"info","ts":"2026-02-16T22:58:10.059615Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","added-peer-id":"90a0cb2044183f95","added-peer-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-02-16T22:58:10.057813Z","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-16T22:58:10.059898Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"90a0cb2044183f95","initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-16T22:58:10.059923Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-16T22:58:10.057829Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-02-16T22:58:10.05995Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-02-16T22:58:10.514691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 is starting a new election at term 1"} {"level":"info","ts":"2026-02-16T22:58:10.514758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-16T22:58:10.514777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgPreVoteResp from 90a0cb2044183f95 at term 1"} {"level":"info","ts":"2026-02-16T22:58:10.514793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became candidate at term 2"} {"level":"info","ts":"2026-02-16T22:58:10.514799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgVoteResp from 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-02-16T22:58:10.514807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became leader at term 2"} {"level":"info","ts":"2026-02-16T22:58:10.514825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 90a0cb2044183f95 elected leader 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-02-16T22:58:10.516198Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-16T22:58:10.517297Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"90a0cb2044183f95","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.233:2379]}","request-path":"/0/members/90a0cb2044183f95/attributes","cluster-id":"782fef34d5ea94f9","publish-timeout":"7s"} {"level":"info","ts":"2026-02-16T22:58:10.51742Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-16T22:58:10.517899Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-16T22:58:10.519442Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.233:2379"} {"level":"info","ts":"2026-02-16T22:58:10.520207Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-16T22:58:10.520248Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-16T22:58:10.520292Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","cluster-version":"3.5"} {"level":"info","ts":"2026-02-16T22:58:10.520391Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-16T22:58:10.520416Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-16T22:58:10.52375Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-16T22:58:16.93879Z","caller":"traceutil/trace.go:171","msg":"trace[1319465075] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"179.204769ms","start":"2026-02-16T22:58:16.759555Z","end":"2026-02-16T22:58:16.93876Z","steps":["trace[1319465075] 'process raft request' (duration: 89.316525ms)","trace[1319465075] 'compare' (duration: 89.528519ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:16.939407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.34052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-16T22:58:16.939471Z","caller":"traceutil/trace.go:171","msg":"trace[958553837] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:283; }","duration":"156.452062ms","start":"2026-02-16T22:58:16.783007Z","end":"2026-02-16T22:58:16.939459Z","steps":["trace[958553837] 'agreement among raft nodes before linearized reading' (duration: 156.30423ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:16.939696Z","caller":"traceutil/trace.go:171","msg":"trace[1463347317] linearizableReadLoop","detail":"{readStateIndex:293; appliedIndex:292; }","duration":"155.453767ms","start":"2026-02-16T22:58:16.783029Z","end":"2026-02-16T22:58:16.938483Z","steps":["trace[1463347317] 'read index received' (duration: 65.801167ms)","trace[1463347317] 'applied index is now lower than readState.Index' (duration: 89.65184ms)"],"step_count":2} {"level":"info","ts":"2026-02-16T22:58:17.129125Z","caller":"traceutil/trace.go:171","msg":"trace[1032944318] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"115.168895ms","start":"2026-02-16T22:58:17.013942Z","end":"2026-02-16T22:58:17.129111Z","steps":["trace[1032944318] 'process raft request' (duration: 36.058318ms)","trace[1032944318] 'compare' (duration: 78.65484ms)"],"step_count":2} {"level":"info","ts":"2026-02-16T22:58:17.129008Z","caller":"traceutil/trace.go:171","msg":"trace[428746168] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"113.033794ms","start":"2026-02-16T22:58:17.01594Z","end":"2026-02-16T22:58:17.128974Z","steps":["trace[428746168] 'process raft request' (duration: 112.952403ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:20.3922Z","caller":"traceutil/trace.go:171","msg":"trace[819175228] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:358; }","duration":"112.565358ms","start":"2026-02-16T22:58:20.27957Z","end":"2026-02-16T22:58:20.392136Z","steps":["trace[819175228] 'read index received' (duration: 102.109669ms)","trace[819175228] 'applied index is now lower than readState.Index' (duration: 10.454749ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:20.392398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.799781ms","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-16T22:58:20.392455Z","caller":"traceutil/trace.go:171","msg":"trace[858693348] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:349; }","duration":"112.866032ms","start":"2026-02-16T22:58:20.279555Z","end":"2026-02-16T22:58:20.392421Z","steps":["trace[858693348] 'agreement among raft nodes before linearized reading' (duration: 112.73172ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:20.392578Z","caller":"traceutil/trace.go:171","msg":"trace[1678942311] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"114.615557ms","start":"2026-02-16T22:58:20.277949Z","end":"2026-02-16T22:58:20.392564Z","steps":["trace[1678942311] 'process raft request' (duration: 103.804363ms)","trace[1678942311] 'compare' (duration: 10.257486ms)"],"step_count":2} {"level":"info","ts":"2026-02-16T22:58:21.36053Z","caller":"traceutil/trace.go:171","msg":"trace[942690173] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"136.983993ms","start":"2026-02-16T22:58:21.223528Z","end":"2026-02-16T22:58:21.360512Z","steps":["trace[942690173] 'process raft request' (duration: 136.890511ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:27.217846Z","caller":"traceutil/trace.go:171","msg":"trace[1318346128] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"116.503325ms","start":"2026-02-16T22:58:27.101324Z","end":"2026-02-16T22:58:27.217827Z","steps":["trace[1318346128] 'process raft request' (duration: 97.486046ms)","trace[1318346128] 'compare' (duration: 18.788825ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:29.173564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.0119ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-16T22:58:34.874938Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740169311281322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-16T22:58:34.98137Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.24137519s","expected-duration":"1s"} {"level":"info","ts":"2026-02-16T22:58:34.981721Z","caller":"traceutil/trace.go:171","msg":"trace[1599951123] linearizableReadLoop","detail":"{readStateIndex:439; appliedIndex:438; }","duration":"606.927747ms","start":"2026-02-16T22:58:34.374768Z","end":"2026-02-16T22:58:34.981696Z","steps":["trace[1599951123] 'read index received' (duration: 606.749551ms)","trace[1599951123] 'applied index is now lower than readState.Index' (duration: 176.436µs)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:34.981837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.043642ms","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-16T22:58:34.981856Z","caller":"traceutil/trace.go:171","msg":"trace[367604989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:424; }","duration":"607.119814ms","start":"2026-02-16T22:58:34.374729Z","end":"2026-02-16T22:58:34.981849Z","steps":["trace[367604989] 'agreement among raft nodes before linearized reading' (duration: 607.038041ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:34.981891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:34.374708Z","time spent":"607.174476ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-16T22:58:34.981833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:33.739858Z","time spent":"1.241964919s","remote":"127.0.0.1:38908","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-16T22:58:34.982109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.61904ms","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-16T22:58:34.982127Z","caller":"traceutil/trace.go:171","msg":"trace[1789735997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:424; }","duration":"500.669692ms","start":"2026-02-16T22:58:34.481453Z","end":"2026-02-16T22:58:34.982122Z","steps":["trace[1789735997] 'agreement among raft nodes before linearized reading' (duration: 500.636811ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:34.98214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:34.481431Z","time spent":"500.705954ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-16T22:58:34.982279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.987504ms","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-16T22:58:34.982292Z","caller":"traceutil/trace.go:171","msg":"trace[1382351868] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:424; }","duration":"387.045656ms","start":"2026-02-16T22:58:34.595243Z","end":"2026-02-16T22:58:34.982288Z","steps":["trace[1382351868] 'agreement among raft nodes before linearized reading' (duration: 387.020225ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:34.982304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:34.595216Z","time spent":"387.085518ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-16T22:58:35.446305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.486733ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-16T22:58:35.446654Z","caller":"traceutil/trace.go:171","msg":"trace[1340067676] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"462.295908ms","start":"2026-02-16T22:58:34.984336Z","end":"2026-02-16T22:58:35.446631Z","steps":["trace[1340067676] 'process raft request' (duration: 226.979295ms)","trace[1340067676] 'compare' (duration: 234.378249ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:35.446866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:34.984318Z","time spent":"462.506516ms","remote":"127.0.0.1:38908","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-16T22:58:35.585998Z","caller":"traceutil/trace.go:171","msg":"trace[810235901] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"591.584185ms","start":"2026-02-16T22:58:34.99439Z","end":"2026-02-16T22:58:35.585974Z","steps":["trace[810235901] 'process raft request' (duration: 591.542294ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:35.586131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:34.994383Z","time spent":"591.682079ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-16T22:58:35.586212Z","caller":"traceutil/trace.go:171","msg":"trace[228462303] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"596.189055ms","start":"2026-02-16T22:58:34.990017Z","end":"2026-02-16T22:58:35.586206Z","steps":["trace[228462303] 'process raft request' (duration: 584.441367ms)","trace[228462303] 'compare' (duration: 11.331993ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:35.586237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:34.989988Z","time spent":"596.234187ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-16T22:58:35.586298Z","caller":"traceutil/trace.go:171","msg":"trace[1604257447] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:439; }","duration":"532.587103ms","start":"2026-02-16T22:58:35.053685Z","end":"2026-02-16T22:58:35.586272Z","steps":["trace[1604257447] 'read index received' (duration: 157.761198ms)","trace[1604257447] 'applied index is now lower than readState.Index' (duration: 374.824945ms)"],"step_count":2} {"level":"info","ts":"2026-02-16T22:58:35.586365Z","caller":"traceutil/trace.go:171","msg":"trace[61843853] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"595.575282ms","start":"2026-02-16T22:58:34.990783Z","end":"2026-02-16T22:58:35.586358Z","steps":["trace[61843853] 'process raft request' (duration: 595.122806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:35.586393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:34.990769Z","time spent":"595.609013ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-16T22:58:35.586504Z","caller":"traceutil/trace.go:171","msg":"trace[754045740] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"591.214612ms","start":"2026-02-16T22:58:34.995282Z","end":"2026-02-16T22:58:35.586496Z","steps":["trace[754045740] 'process raft request' (duration: 590.668672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:35.586592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:34.995275Z","time spent":"591.248543ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-16T22:58:35.586669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.402451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-16T22:58:35.586694Z","caller":"traceutil/trace.go:171","msg":"trace[910403183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"144.455572ms","start":"2026-02-16T22:58:35.442231Z","end":"2026-02-16T22:58:35.586687Z","steps":["trace[910403183] 'agreement among raft nodes before linearized reading' (duration: 144.416791ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:35.586783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.099432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-16T22:58:35.58681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.208645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-16T22:58:35.586827Z","caller":"traceutil/trace.go:171","msg":"trace[1363936878] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:429; }","duration":"138.239276ms","start":"2026-02-16T22:58:35.448582Z","end":"2026-02-16T22:58:35.586821Z","steps":["trace[1363936878] 'agreement among raft nodes before linearized reading' (duration: 138.205795ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:35.586807Z","caller":"traceutil/trace.go:171","msg":"trace[1943689972] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"533.160974ms","start":"2026-02-16T22:58:35.05364Z","end":"2026-02-16T22:58:35.586801Z","steps":["trace[1943689972] 'agreement among raft nodes before linearized reading' (duration: 533.120592ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:35.589509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:35.053622Z","time spent":"535.851422ms","remote":"127.0.0.1:38878","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-16T22:58:42.11953Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740169311281425,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-16T22:58:42.558723Z","caller":"traceutil/trace.go:171","msg":"trace[1530130225] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:488; }","duration":"940.037969ms","start":"2026-02-16T22:58:41.618664Z","end":"2026-02-16T22:58:42.558702Z","steps":["trace[1530130225] 'read index received' (duration: 939.825482ms)","trace[1530130225] 'applied index is now lower than readState.Index' (duration: 211.537µs)"],"step_count":2} {"level":"info","ts":"2026-02-16T22:58:42.559094Z","caller":"traceutil/trace.go:171","msg":"trace[126584071] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"988.041089ms","start":"2026-02-16T22:58:41.571037Z","end":"2026-02-16T22:58:42.559078Z","steps":["trace[126584071] 'process raft request' (duration: 987.546032ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:42.559223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:41.571023Z","time spent":"988.118572ms","remote":"127.0.0.1:39044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4211,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-16T22:58:42.559482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.812046ms","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-16T22:58:42.559521Z","caller":"traceutil/trace.go:171","msg":"trace[1396092359] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:473; }","duration":"940.870708ms","start":"2026-02-16T22:58:41.618637Z","end":"2026-02-16T22:58:42.559507Z","steps":["trace[1396092359] 'agreement among raft nodes before linearized reading' (duration: 940.804676ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:42.55955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:41.618625Z","time spent":"940.918519ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-16T22:58:42.559709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.367888ms","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-16T22:58:42.559755Z","caller":"traceutil/trace.go:171","msg":"trace[1515402577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:473; }","duration":"933.411409ms","start":"2026-02-16T22:58:41.626334Z","end":"2026-02-16T22:58:42.559746Z","steps":["trace[1515402577] 'agreement among raft nodes before linearized reading' (duration: 933.348327ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:42.559788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:41.626308Z","time spent":"933.471591ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-16T22:58:42.560028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.669028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-16T22:58:42.560058Z","caller":"traceutil/trace.go:171","msg":"trace[1893710827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:473; }","duration":"108.698408ms","start":"2026-02-16T22:58:42.45135Z","end":"2026-02-16T22:58:42.560049Z","steps":["trace[1893710827] 'agreement among raft nodes before linearized reading' (duration: 108.656027ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:42.563286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"934.60341ms","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-16T22:58:42.563335Z","caller":"traceutil/trace.go:171","msg":"trace[1052400992] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:473; }","duration":"934.684772ms","start":"2026-02-16T22:58:41.628638Z","end":"2026-02-16T22:58:42.563322Z","steps":["trace[1052400992] 'agreement among raft nodes before linearized reading' (duration: 934.60247ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:42.563365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:41.62862Z","time spent":"934.738354ms","remote":"127.0.0.1:39142","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-16T22:58:42.563398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.95051ms","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-16T22:58:42.563482Z","caller":"traceutil/trace.go:171","msg":"trace[340227505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:473; }","duration":"937.049914ms","start":"2026-02-16T22:58:41.626408Z","end":"2026-02-16T22:58:42.563458Z","steps":["trace[340227505] 'agreement among raft nodes before linearized reading' (duration: 936.887239ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:42.563531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:41.626403Z","time spent":"937.116956ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-16T22:58:46.087068Z","caller":"traceutil/trace.go:171","msg":"trace[524753026] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"109.433439ms","start":"2026-02-16T22:58:45.977616Z","end":"2026-02-16T22:58:46.08705Z","steps":["trace[524753026] 'process raft request' (duration: 109.397688ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:46.087669Z","caller":"traceutil/trace.go:171","msg":"trace[160303368] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"175.470378ms","start":"2026-02-16T22:58:45.912184Z","end":"2026-02-16T22:58:46.087654Z","steps":["trace[160303368] 'process raft request' (duration: 103.893723ms)","trace[160303368] 'compare' (duration: 70.607863ms)"],"step_count":2} {"level":"info","ts":"2026-02-16T22:58:46.087956Z","caller":"traceutil/trace.go:171","msg":"trace[1853095265] linearizableReadLoop","detail":"{readStateIndex:512; appliedIndex:511; }","duration":"165.012159ms","start":"2026-02-16T22:58:45.922932Z","end":"2026-02-16T22:58:46.087944Z","steps":["trace[1853095265] 'read index received' (duration: 93.154054ms)","trace[1853095265] 'applied index is now lower than readState.Index' (duration: 71.856995ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:46.088178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.193795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-16T22:58:46.08828Z","caller":"traceutil/trace.go:171","msg":"trace[1021484608] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"164.864134ms","start":"2026-02-16T22:58:45.92339Z","end":"2026-02-16T22:58:46.088254Z","steps":["trace[1021484608] 'process raft request' (duration: 163.52361ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:46.088299Z","caller":"traceutil/trace.go:171","msg":"trace[359349511] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:498; }","duration":"165.372471ms","start":"2026-02-16T22:58:45.922913Z","end":"2026-02-16T22:58:46.088285Z","steps":["trace[359349511] 'agreement among raft nodes before linearized reading' (duration: 165.159304ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:46.08855Z","caller":"traceutil/trace.go:171","msg":"trace[204241193] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"163.071114ms","start":"2026-02-16T22:58:45.925471Z","end":"2026-02-16T22:58:46.088543Z","steps":["trace[204241193] 'process raft request' (duration: 161.500792ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:46.295703Z","caller":"traceutil/trace.go:171","msg":"trace[1064845928] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"106.885328ms","start":"2026-02-16T22:58:46.188797Z","end":"2026-02-16T22:58:46.295682Z","steps":["trace[1064845928] 'process raft request' (duration: 34.559747ms)","trace[1064845928] 'compare' (duration: 71.853005ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:51.203676Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740169311281516,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-16T22:58:51.617607Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.058766717s","expected-duration":"1s"} {"level":"info","ts":"2026-02-16T22:58:51.61793Z","caller":"traceutil/trace.go:171","msg":"trace[1846793299] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:535; }","duration":"915.12313ms","start":"2026-02-16T22:58:50.702786Z","end":"2026-02-16T22:58:51.617909Z","steps":["trace[1846793299] 'read index received' (duration: 914.938984ms)","trace[1846793299] 'applied index is now lower than readState.Index' (duration: 183.246µs)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:51.618702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.585684ms","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-16T22:58:51.618731Z","caller":"traceutil/trace.go:171","msg":"trace[1274276113] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:518; }","duration":"901.656917ms","start":"2026-02-16T22:58:50.717068Z","end":"2026-02-16T22:58:51.618724Z","steps":["trace[1274276113] 'agreement among raft nodes before linearized reading' (duration: 901.521092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:51.618754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:50.717052Z","time spent":"901.697709ms","remote":"127.0.0.1:39142","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-16T22:58:51.618905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.119231ms","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-16T22:58:51.618923Z","caller":"traceutil/trace.go:171","msg":"trace[564579248] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"916.169033ms","start":"2026-02-16T22:58:50.70275Z","end":"2026-02-16T22:58:51.618919Z","steps":["trace[564579248] 'agreement among raft nodes before linearized reading' (duration: 916.103671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:51.618953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:50.702734Z","time spent":"916.215495ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-16T22:58:51.619049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.501853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-16T22:58:51.619069Z","caller":"traceutil/trace.go:171","msg":"trace[115865511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"173.523994ms","start":"2026-02-16T22:58:51.445541Z","end":"2026-02-16T22:58:51.619065Z","steps":["trace[115865511] 'agreement among raft nodes before linearized reading' (duration: 173.493543ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:51.619221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.633477ms","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-16T22:58:51.61924Z","caller":"traceutil/trace.go:171","msg":"trace[336323879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:518; }","duration":"841.676879ms","start":"2026-02-16T22:58:50.777558Z","end":"2026-02-16T22:58:51.619235Z","steps":["trace[336323879] 'agreement among raft nodes before linearized reading' (duration: 841.612097ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:51.619365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:50.777537Z","time spent":"841.822573ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-16T22:58:51.61948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.990848ms","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-16T22:58:51.619499Z","caller":"traceutil/trace.go:171","msg":"trace[340054682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"865.037329ms","start":"2026-02-16T22:58:50.754457Z","end":"2026-02-16T22:58:51.619495Z","steps":["trace[340054682] 'agreement among raft nodes before linearized reading' (duration: 864.977277ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:51.619512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:50.754442Z","time spent":"865.067741ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-16T22:58:51.61821Z","caller":"traceutil/trace.go:171","msg":"trace[132894609] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.059444739s","start":"2026-02-16T22:58:50.558755Z","end":"2026-02-16T22:58:51.618199Z","steps":["trace[132894609] 'process raft request' (duration: 1.059036076s)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:51.620035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:50.558739Z","time spent":"1.061248026s","remote":"127.0.0.1:39060","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-16T22:58:53.942328Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740169311281520,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-16T22:58:54.371025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:52.315822Z","time spent":"2.055198225s","remote":"127.0.0.1:51524","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-16T22:58:54.374469Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.597656375s","expected-duration":"1s"} {"level":"info","ts":"2026-02-16T22:58:54.374641Z","caller":"traceutil/trace.go:171","msg":"trace[801384091] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:540; }","duration":"932.738701ms","start":"2026-02-16T22:58:53.441891Z","end":"2026-02-16T22:58:54.37463Z","steps":["trace[801384091] 'read index received' (duration: 932.622167ms)","trace[801384091] 'applied index is now lower than readState.Index' (duration: 116.064µs)"],"step_count":2} {"level":"info","ts":"2026-02-16T22:58:54.374751Z","caller":"traceutil/trace.go:171","msg":"trace[1830881465] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"1.597998135s","start":"2026-02-16T22:58:52.776748Z","end":"2026-02-16T22:58:54.374746Z","steps":["trace[1830881465] 'process raft request' (duration: 1.597806289s)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:54.374805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:52.776733Z","time spent":"1.598031627s","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-16T22:58:54.37551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.622328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-16T22:58:54.375534Z","caller":"traceutil/trace.go:171","msg":"trace[1143183304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"933.67365ms","start":"2026-02-16T22:58:53.441855Z","end":"2026-02-16T22:58:54.375528Z","steps":["trace[1143183304] 'agreement among raft nodes before linearized reading' (duration: 933.632128ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:54.375549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:53.441822Z","time spent":"933.724191ms","remote":"127.0.0.1:38878","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-16T22:58:54.375738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.131334ms","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-16T22:58:54.375758Z","caller":"traceutil/trace.go:171","msg":"trace[1173318726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:523; }","duration":"720.174975ms","start":"2026-02-16T22:58:53.655579Z","end":"2026-02-16T22:58:54.375754Z","steps":["trace[1173318726] 'agreement among raft nodes before linearized reading' (duration: 720.090822ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:54.375772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:53.655566Z","time spent":"720.202526ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-16T22:58:54.376007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.282591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.233\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-16T22:58:54.376036Z","caller":"traceutil/trace.go:171","msg":"trace[1367949035] range","detail":"{range_begin:/registry/masterleases/199.204.45.233; range_end:; response_count:1; response_revision:523; }","duration":"636.370033ms","start":"2026-02-16T22:58:53.739661Z","end":"2026-02-16T22:58:54.376031Z","steps":["trace[1367949035] 'agreement among raft nodes before linearized reading' (duration: 636.306041ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:54.376049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:53.739642Z","time spent":"636.403225ms","remote":"127.0.0.1:38908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.233\" "} {"level":"warn","ts":"2026-02-16T22:58:54.37689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.428813ms","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-16T22:58:54.376912Z","caller":"traceutil/trace.go:171","msg":"trace[921856757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:523; }","duration":"691.472353ms","start":"2026-02-16T22:58:53.685434Z","end":"2026-02-16T22:58:54.376907Z","steps":["trace[921856757] 'agreement among raft nodes before linearized reading' (duration: 690.685189ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:54.376925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:53.685424Z","time spent":"691.497355ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-16T22:58:54.378487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.328804ms","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-16T22:58:54.378509Z","caller":"traceutil/trace.go:171","msg":"trace[1698347876] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:523; }","duration":"695.380726ms","start":"2026-02-16T22:58:53.683123Z","end":"2026-02-16T22:58:54.378504Z","steps":["trace[1698347876] 'agreement among raft nodes before linearized reading' (duration: 695.330485ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:54.379376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.373513ms","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-16T22:58:54.379458Z","caller":"traceutil/trace.go:171","msg":"trace[1766358326] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:523; }","duration":"695.638994ms","start":"2026-02-16T22:58:53.683797Z","end":"2026-02-16T22:58:54.379436Z","steps":["trace[1766358326] 'agreement among raft nodes before linearized reading' (duration: 692.741924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:54.380094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:53.683787Z","time spent":"695.688585ms","remote":"127.0.0.1:39142","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-16T22:58:54.380741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:53.683106Z","time spent":"695.413267ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-16T22:58:58.933592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.599488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-02-16T22:58:58.933651Z","caller":"traceutil/trace.go:171","msg":"trace[1414886504] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:590; }","duration":"123.726242ms","start":"2026-02-16T22:58:58.80991Z","end":"2026-02-16T22:58:58.933636Z","steps":["trace[1414886504] 'range keys from in-memory index tree' (duration: 123.422382ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:59:14.330294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.357499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-16T22:59:14.330363Z","caller":"traceutil/trace.go:171","msg":"trace[1512515786] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"574.392286ms","start":"2026-02-16T22:59:13.755961Z","end":"2026-02-16T22:59:14.330353Z","steps":["trace[1512515786] 'process raft request' (duration: 204.928175ms)","trace[1512515786] 'compare' (duration: 369.181754ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:59:14.330393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:59:13.755946Z","time spent":"574.433867ms","remote":"127.0.0.1:38908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-16T22:59:14.667555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.671509ms","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-16T22:59:14.667608Z","caller":"traceutil/trace.go:171","msg":"trace[1984246830] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:724; }","duration":"113.75635ms","start":"2026-02-16T22:59:14.553839Z","end":"2026-02-16T22:59:14.667595Z","steps":["trace[1984246830] 'range keys from in-memory index tree' (duration: 113.597966ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:59:14.668049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.625104ms","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-16T22:59:14.668072Z","caller":"traceutil/trace.go:171","msg":"trace[562730537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:724; }","duration":"145.648794ms","start":"2026-02-16T22:59:14.522418Z","end":"2026-02-16T22:59:14.668067Z","steps":["trace[562730537] 'range keys from in-memory index tree' (duration: 145.52492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:59:14.671002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.891081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-16T22:59:14.671171Z","caller":"traceutil/trace.go:171","msg":"trace[1937143601] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:724; }","duration":"228.090736ms","start":"2026-02-16T22:59:14.443045Z","end":"2026-02-16T22:59:14.671136Z","steps":["trace[1937143601] 'range keys from in-memory index tree' (duration: 224.717355ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:59:14.781966Z","caller":"traceutil/trace.go:171","msg":"trace[977620261] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"103.060441ms","start":"2026-02-16T22:59:14.678891Z","end":"2026-02-16T22:59:14.781952Z","steps":["trace[977620261] 'process raft request' (duration: 101.807967ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:34.135124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.168187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-16T23:00:34.135187Z","caller":"traceutil/trace.go:171","msg":"trace[1790037655] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:990; }","duration":"155.287799ms","start":"2026-02-16T23:00:33.979885Z","end":"2026-02-16T23:00:34.135173Z","steps":["trace[1790037655] 'count revisions from in-memory index tree' (duration: 155.102796ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:34.135262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.648754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-16T23:00:34.135306Z","caller":"traceutil/trace.go:171","msg":"trace[1201060224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:990; }","duration":"692.718434ms","start":"2026-02-16T23:00:33.442576Z","end":"2026-02-16T23:00:34.135294Z","steps":["trace[1201060224] 'range keys from in-memory index tree' (duration: 692.581132ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:34.13534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T23:00:33.442545Z","time spent":"692.785666ms","remote":"127.0.0.1:38878","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-16T23:00:34.135488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.85523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.233\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-16T23:00:34.135507Z","caller":"traceutil/trace.go:171","msg":"trace[1550790347] range","detail":"{range_begin:/registry/masterleases/199.204.45.233; range_end:; response_count:1; response_revision:990; }","duration":"390.923091ms","start":"2026-02-16T23:00:33.744578Z","end":"2026-02-16T23:00:34.135501Z","steps":["trace[1550790347] 'range keys from in-memory index tree' (duration: 390.738078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:34.135523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T23:00:33.74456Z","time spent":"390.958832ms","remote":"127.0.0.1:38908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.233\" "} {"level":"warn","ts":"2026-02-16T23:00:34.135578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.941163ms","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-16T23:00:34.135617Z","caller":"traceutil/trace.go:171","msg":"trace[1448666630] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:990; }","duration":"687.992193ms","start":"2026-02-16T23:00:33.447613Z","end":"2026-02-16T23:00:34.135605Z","steps":["trace[1448666630] 'range keys from in-memory index tree' (duration: 687.81829ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:34.135644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T23:00:33.447607Z","time spent":"688.030614ms","remote":"127.0.0.1:39142","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-16T23:00:34.135827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.708827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-16T23:00:34.135862Z","caller":"traceutil/trace.go:171","msg":"trace[1450315380] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:990; }","duration":"675.758888ms","start":"2026-02-16T23:00:33.460093Z","end":"2026-02-16T23:00:34.135851Z","steps":["trace[1450315380] 'count revisions from in-memory index tree' (duration: 675.664986ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:34.13589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T23:00:33.460086Z","time spent":"675.795959ms","remote":"127.0.0.1:57694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-02-16T23:00:34.135994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.76674ms","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-16T23:00:34.136013Z","caller":"traceutil/trace.go:171","msg":"trace[603268042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:990; }","duration":"479.79921ms","start":"2026-02-16T23:00:33.656208Z","end":"2026-02-16T23:00:34.136007Z","steps":["trace[603268042] 'range keys from in-memory index tree' (duration: 479.708718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:34.136029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T23:00:33.6562Z","time spent":"479.8254ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-16T23:00:34.136066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.94666ms","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-16T23:00:34.136091Z","caller":"traceutil/trace.go:171","msg":"trace[1166533558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:990; }","duration":"470.999212ms","start":"2026-02-16T23:00:33.665084Z","end":"2026-02-16T23:00:34.136084Z","steps":["trace[1166533558] 'range keys from in-memory index tree' (duration: 470.850418ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:34.136115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T23:00:33.665071Z","time spent":"471.038702ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-16T23:00:34.136263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.926255ms","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-16T23:00:34.136284Z","caller":"traceutil/trace.go:171","msg":"trace[1157952995] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:990; }","duration":"489.982096ms","start":"2026-02-16T23:00:33.646296Z","end":"2026-02-16T23:00:34.136278Z","steps":["trace[1157952995] 'range keys from in-memory index tree' (duration: 489.834263ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:34.1363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T23:00:33.646277Z","time spent":"490.018447ms","remote":"127.0.0.1:39142","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-16T23:00:36.920899Z","caller":"traceutil/trace.go:171","msg":"trace[93024145] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"438.768852ms","start":"2026-02-16T23:00:36.482112Z","end":"2026-02-16T23:00:36.920881Z","steps":["trace[93024145] 'process raft request' (duration: 438.66842ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:36.923859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T23:00:36.482092Z","time spent":"441.711598ms","remote":"127.0.0.1:39142","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-16T23:00:51.952457Z","caller":"traceutil/trace.go:171","msg":"trace[1340218275] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"416.987722ms","start":"2026-02-16T23:00:51.53544Z","end":"2026-02-16T23:00:51.952428Z","steps":["trace[1340218275] 'process raft request' (duration: 416.469842ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:51.952799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T23:00:51.535423Z","time spent":"417.256666ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-16T23:00:56.861567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.701575ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-16T23:00:56.861867Z","caller":"traceutil/trace.go:171","msg":"trace[1638053591] linearizableReadLoop","detail":"{readStateIndex:1108; appliedIndex:1107; }","duration":"256.26835ms","start":"2026-02-16T23:00:56.605578Z","end":"2026-02-16T23:00:56.861846Z","steps":["trace[1638053591] 'read index received' (duration: 106.135838ms)","trace[1638053591] 'applied index is now lower than readState.Index' (duration: 150.131102ms)"],"step_count":2} {"level":"info","ts":"2026-02-16T23:00:56.86214Z","caller":"traceutil/trace.go:171","msg":"trace[1392772905] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"293.818296ms","start":"2026-02-16T23:00:56.568305Z","end":"2026-02-16T23:00:56.862123Z","steps":["trace[1392772905] 'process raft request' (duration: 143.47635ms)","trace[1392772905] 'compare' (duration: 149.568222ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T23:00:56.862631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.072249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/kube-system/\" range_end:\"/registry/persistentvolumeclaims/kube-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-16T23:00:56.863372Z","caller":"traceutil/trace.go:171","msg":"trace[1252167998] range","detail":"{range_begin:/registry/persistentvolumeclaims/kube-system/; range_end:/registry/persistentvolumeclaims/kube-system0; response_count:0; response_revision:1061; }","duration":"226.67765ms","start":"2026-02-16T23:00:56.63651Z","end":"2026-02-16T23:00:56.863188Z","steps":["trace[1252167998] 'agreement among raft nodes before linearized reading' (duration: 226.031748ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:56.862836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.264368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4687"} {"level":"info","ts":"2026-02-16T23:00:56.863824Z","caller":"traceutil/trace.go:171","msg":"trace[1481070242] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:1061; }","duration":"258.269277ms","start":"2026-02-16T23:00:56.605541Z","end":"2026-02-16T23:00:56.863811Z","steps":["trace[1481070242] 'agreement among raft nodes before linearized reading' (duration: 257.158977ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:56.862948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.426447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/\" range_end:\"/registry/rolebindings/kube-system0\" limit:500 ","response":"range_response_count:11 size:7467"} {"level":"info","ts":"2026-02-16T23:00:56.864685Z","caller":"traceutil/trace.go:171","msg":"trace[428112437] range","detail":"{range_begin:/registry/rolebindings/kube-system/; range_end:/registry/rolebindings/kube-system0; response_count:11; response_revision:1061; }","duration":"180.957535ms","start":"2026-02-16T23:00:56.683512Z","end":"2026-02-16T23:00:56.864469Z","steps":["trace[428112437] 'agreement among raft nodes before linearized reading' (duration: 179.343826ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T23:00:56.863038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.11264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-02-16T23:00:56.865138Z","caller":"traceutil/trace.go:171","msg":"trace[442663903] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:1061; }","duration":"205.240808ms","start":"2026-02-16T23:00:56.659885Z","end":"2026-02-16T23:00:56.865126Z","steps":["trace[442663903] 'agreement among raft nodes before linearized reading' (duration: 203.079409ms)"],"step_count":1}