{"level":"warn","ts":"2026-02-26T20:55:04.346454Z","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-26T20:55:04.346597Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70: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.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70: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-26T20:55:04.346668Z","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-26T20:55:04.34668Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-02-26T20:55:04.346698Z","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-26T20:55:04.347513Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-02-26T20:55:04.347586Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70: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-26T20:55:04.35165Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.856371ms"} {"level":"info","ts":"2026-02-26T20:55:04.359893Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-02-26T20:55:04.361339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T20:55:04.361428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-02-26T20:55:04.361475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T20:55:04.361535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-02-26T20:55:04.361608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-02-26T20:55:04.369618Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T20:55:04.371078Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T20:55:04.374446Z","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-26T20:55:04.376799Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T20:55:04.376992Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T20:55:04.377098Z","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-26T20:55:04.377147Z","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-26T20:55:04.377165Z","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-26T20:55:04.379259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-02-26T20:55:04.379773Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-02-26T20:55:04.381751Z","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-26T20:55:04.381954Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-02-26T20:55:04.381985Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-02-26T20:55:04.382291Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T20:55:04.382343Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T20:55:04.862818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T20:55:04.863073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T20:55:04.863253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-02-26T20:55:04.863375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-02-26T20:55:04.863454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-02-26T20:55:04.863531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-02-26T20:55:04.863626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-02-26T20:55:04.864643Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T20:55:04.864907Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T20:55:04.865107Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T20:55:04.866001Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T20:55:04.866244Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T20:55:04.866283Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T20:55:04.866681Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T20:55:04.868108Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T20:55:04.868153Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T20:55:04.868843Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T20:55:04.870006Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"warn","ts":"2026-02-26T20:55:15.867424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.479086ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T20:55:15.867536Z","caller":"traceutil/trace.go:171","msg":"trace[720874473] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:362; }","duration":"134.019043ms","start":"2026-02-26T20:55:15.733503Z","end":"2026-02-26T20:55:15.867522Z","steps":["trace[720874473] 'read index received' (duration: 14.179405ms)","trace[720874473] 'applied index is now lower than readState.Index' (duration: 119.838008ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T20:55:15.867606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.097534ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T20:55:15.867679Z","caller":"traceutil/trace.go:171","msg":"trace[1213449082] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:351; }","duration":"134.169304ms","start":"2026-02-26T20:55:15.733496Z","end":"2026-02-26T20:55:15.867665Z","steps":["trace[1213449082] 'agreement among raft nodes before linearized reading' (duration: 134.075944ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:15.86797Z","caller":"traceutil/trace.go:171","msg":"trace[1792045781] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"361.952167ms","start":"2026-02-26T20:55:15.505985Z","end":"2026-02-26T20:55:15.867937Z","steps":["trace[1792045781] 'process raft request' (duration: 241.739585ms)","trace[1792045781] 'compare' (duration: 118.279344ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T20:55:15.86811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:15.505965Z","time spent":"362.069979ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T20:55:16.056117Z","caller":"traceutil/trace.go:171","msg":"trace[1624238000] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"178.319928ms","start":"2026-02-26T20:55:15.877781Z","end":"2026-02-26T20:55:16.056101Z","steps":["trace[1624238000] 'process raft request' (duration: 104.483302ms)","trace[1624238000] 'compare' (duration: 73.336381ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T20:55:21.023449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.864009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T20:55:21.023552Z","caller":"traceutil/trace.go:171","msg":"trace[1518978994] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"335.308182ms","start":"2026-02-26T20:55:20.688226Z","end":"2026-02-26T20:55:21.023535Z","steps":["trace[1518978994] 'process raft request' (duration: 199.293013ms)","trace[1518978994] 'compare' (duration: 135.764867ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T20:55:21.023605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:20.688207Z","time spent":"335.372344ms","remote":"127.0.0.1:42050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T20:55:21.023975Z","caller":"traceutil/trace.go:171","msg":"trace[1549187024] linearizableReadLoop","detail":"{readStateIndex:390; appliedIndex:387; }","duration":"189.280282ms","start":"2026-02-26T20:55:20.834674Z","end":"2026-02-26T20:55:21.023954Z","steps":["trace[1549187024] 'read index received' (duration: 52.931319ms)","trace[1549187024] 'applied index is now lower than readState.Index' (duration: 136.348103ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:55:21.024088Z","caller":"traceutil/trace.go:171","msg":"trace[1766309034] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"335.610126ms","start":"2026-02-26T20:55:20.688421Z","end":"2026-02-26T20:55:21.024031Z","steps":["trace[1766309034] 'process raft request' (duration: 335.491385ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.024102Z","caller":"traceutil/trace.go:171","msg":"trace[616556711] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"335.749157ms","start":"2026-02-26T20:55:20.688283Z","end":"2026-02-26T20:55:21.024032Z","steps":["trace[616556711] 'process raft request' (duration: 335.536045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:21.024195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.469463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T20:55:21.024243Z","caller":"traceutil/trace.go:171","msg":"trace[1659071604] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:377; }","duration":"189.605454ms","start":"2026-02-26T20:55:20.834625Z","end":"2026-02-26T20:55:21.02423Z","steps":["trace[1659071604] 'agreement among raft nodes before linearized reading' (duration: 189.448623ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:21.024268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:20.688414Z","time spent":"335.777807ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3563,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T20:55:21.024317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:20.688257Z","time spent":"335.978308ms","remote":"127.0.0.1:41646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T20:55:21.275953Z","caller":"traceutil/trace.go:171","msg":"trace[1067309673] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"245.165599ms","start":"2026-02-26T20:55:21.030768Z","end":"2026-02-26T20:55:21.275934Z","steps":["trace[1067309673] 'process raft request' (duration: 245.026538ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.27598Z","caller":"traceutil/trace.go:171","msg":"trace[2134661120] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"245.37988ms","start":"2026-02-26T20:55:21.030564Z","end":"2026-02-26T20:55:21.275944Z","steps":["trace[2134661120] 'process raft request' (duration: 245.202118ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.276201Z","caller":"traceutil/trace.go:171","msg":"trace[949240619] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"245.673703ms","start":"2026-02-26T20:55:21.030506Z","end":"2026-02-26T20:55:21.27618Z","steps":["trace[949240619] 'process raft request' (duration: 245.199479ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.276194Z","caller":"traceutil/trace.go:171","msg":"trace[1633118283] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"245.612502ms","start":"2026-02-26T20:55:21.030503Z","end":"2026-02-26T20:55:21.276116Z","steps":["trace[1633118283] 'process raft request' (duration: 163.617378ms)","trace[1633118283] 'compare' (duration: 81.43663ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:55:21.276435Z","caller":"traceutil/trace.go:171","msg":"trace[2058433642] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"245.31584ms","start":"2026-02-26T20:55:21.031105Z","end":"2026-02-26T20:55:21.276421Z","steps":["trace[2058433642] 'process raft request' (duration: 244.797176ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.276511Z","caller":"traceutil/trace.go:171","msg":"trace[1246763771] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"243.08585ms","start":"2026-02-26T20:55:21.033417Z","end":"2026-02-26T20:55:21.276503Z","steps":["trace[1246763771] 'process raft request' (duration: 242.881178ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.535722Z","caller":"traceutil/trace.go:171","msg":"trace[727113097] linearizableReadLoop","detail":"{readStateIndex:401; appliedIndex:400; }","duration":"177.548982ms","start":"2026-02-26T20:55:21.358141Z","end":"2026-02-26T20:55:21.53569Z","steps":["trace[727113097] 'read index received' (duration: 109.32776ms)","trace[727113097] 'applied index is now lower than readState.Index' (duration: 68.220092ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:55:21.535839Z","caller":"traceutil/trace.go:171","msg":"trace[1358294917] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"186.052608ms","start":"2026-02-26T20:55:21.349763Z","end":"2026-02-26T20:55:21.535815Z","steps":["trace[1358294917] 'process raft request' (duration: 117.692285ms)","trace[1358294917] 'compare' (duration: 68.13194ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T20:55:21.535897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.744054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"} {"level":"info","ts":"2026-02-26T20:55:21.535932Z","caller":"traceutil/trace.go:171","msg":"trace[1195880584] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:388; }","duration":"177.831105ms","start":"2026-02-26T20:55:21.35809Z","end":"2026-02-26T20:55:21.535921Z","steps":["trace[1195880584] 'agreement among raft nodes before linearized reading' (duration: 177.704184ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.553993Z","caller":"traceutil/trace.go:171","msg":"trace[999456476] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"192.458726ms","start":"2026-02-26T20:55:21.361514Z","end":"2026-02-26T20:55:21.553973Z","steps":["trace[999456476] 'process raft request' (duration: 192.331465ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.679129Z","caller":"traceutil/trace.go:171","msg":"trace[1748751880] transaction","detail":"{read_only:false; number_of_response:1; response_revision:389; }","duration":"141.747701ms","start":"2026-02-26T20:55:21.537351Z","end":"2026-02-26T20:55:21.679098Z","steps":["trace[1748751880] 'process raft request' (duration: 102.048946ms)","trace[1748751880] 'compare' (duration: 39.480304ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:55:21.679171Z","caller":"traceutil/trace.go:171","msg":"trace[1616105351] transaction","detail":"{read_only:false; number_of_response:1; response_revision:390; }","duration":"137.664374ms","start":"2026-02-26T20:55:21.541485Z","end":"2026-02-26T20:55:21.679149Z","steps":["trace[1616105351] 'process raft request' (duration: 137.620004ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.679257Z","caller":"traceutil/trace.go:171","msg":"trace[407435708] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"139.021307ms","start":"2026-02-26T20:55:21.540206Z","end":"2026-02-26T20:55:21.679227Z","steps":["trace[407435708] 'process raft request' (duration: 138.791945ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.680026Z","caller":"traceutil/trace.go:171","msg":"trace[678355845] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"119.3227ms","start":"2026-02-26T20:55:21.560689Z","end":"2026-02-26T20:55:21.680011Z","steps":["trace[678355845] 'process raft request' (duration: 119.27815ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.68004Z","caller":"traceutil/trace.go:171","msg":"trace[140489966] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"123.018223ms","start":"2026-02-26T20:55:21.55701Z","end":"2026-02-26T20:55:21.680028Z","steps":["trace[140489966] 'process raft request' (duration: 122.872532ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.890643Z","caller":"traceutil/trace.go:171","msg":"trace[1533968206] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"200.958162ms","start":"2026-02-26T20:55:21.689658Z","end":"2026-02-26T20:55:21.890616Z","steps":["trace[1533968206] 'process raft request' (duration: 128.374531ms)","trace[1533968206] 'compare' (duration: 72.386569ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:55:21.890858Z","caller":"traceutil/trace.go:171","msg":"trace[1767749368] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"201.003961ms","start":"2026-02-26T20:55:21.689817Z","end":"2026-02-26T20:55:21.890821Z","steps":["trace[1767749368] 'process raft request' (duration: 200.749089ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.890895Z","caller":"traceutil/trace.go:171","msg":"trace[1654258151] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"199.601549ms","start":"2026-02-26T20:55:21.691267Z","end":"2026-02-26T20:55:21.890868Z","steps":["trace[1654258151] 'process raft request' (duration: 199.469808ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.952232Z","caller":"traceutil/trace.go:171","msg":"trace[1566152965] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"177.731023ms","start":"2026-02-26T20:55:21.774474Z","end":"2026-02-26T20:55:21.952205Z","steps":["trace[1566152965] 'process raft request' (duration: 177.643362ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.952273Z","caller":"traceutil/trace.go:171","msg":"trace[1700133962] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"179.525909ms","start":"2026-02-26T20:55:21.77271Z","end":"2026-02-26T20:55:21.952236Z","steps":["trace[1700133962] 'process raft request' (duration: 179.357218ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:21.95245Z","caller":"traceutil/trace.go:171","msg":"trace[1508760250] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"179.820142ms","start":"2026-02-26T20:55:21.772576Z","end":"2026-02-26T20:55:21.952396Z","steps":["trace[1508760250] 'process raft request' (duration: 179.366828ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:34.660474Z","caller":"traceutil/trace.go:171","msg":"trace[2083337217] linearizableReadLoop","detail":"{readStateIndex:486; appliedIndex:485; }","duration":"218.758423ms","start":"2026-02-26T20:55:34.441688Z","end":"2026-02-26T20:55:34.660446Z","steps":["trace[2083337217] 'read index received' (duration: 218.524992ms)","trace[2083337217] 'applied index is now lower than readState.Index' (duration: 232.571µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:55:34.660536Z","caller":"traceutil/trace.go:171","msg":"trace[2141163621] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"436.781631ms","start":"2026-02-26T20:55:34.223721Z","end":"2026-02-26T20:55:34.660502Z","steps":["trace[2141163621] 'process raft request' (duration: 436.569389ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:34.660625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.923714ms","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-26T20:55:34.660665Z","caller":"traceutil/trace.go:171","msg":"trace[504927827] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:468; }","duration":"219.014196ms","start":"2026-02-26T20:55:34.441637Z","end":"2026-02-26T20:55:34.660651Z","steps":["trace[504927827] 'agreement among raft nodes before linearized reading' (duration: 218.927105ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:34.660682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:34.223711Z","time spent":"436.892712ms","remote":"127.0.0.1:41848","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-26T20:55:35.340251Z","caller":"traceutil/trace.go:171","msg":"trace[1784964173] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"219.874921ms","start":"2026-02-26T20:55:35.120347Z","end":"2026-02-26T20:55:35.340222Z","steps":["trace[1784964173] 'process raft request' (duration: 219.183326ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:37.845534Z","caller":"traceutil/trace.go:171","msg":"trace[1887878553] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"111.435797ms","start":"2026-02-26T20:55:37.734073Z","end":"2026-02-26T20:55:37.845509Z","steps":["trace[1887878553] 'process raft request' (duration: 111.407827ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:37.845552Z","caller":"traceutil/trace.go:171","msg":"trace[1940253211] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"114.787853ms","start":"2026-02-26T20:55:37.73073Z","end":"2026-02-26T20:55:37.845518Z","steps":["trace[1940253211] 'process raft request' (duration: 114.604192ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:37.845581Z","caller":"traceutil/trace.go:171","msg":"trace[1488364544] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"114.526591ms","start":"2026-02-26T20:55:37.73103Z","end":"2026-02-26T20:55:37.845556Z","steps":["trace[1488364544] 'process raft request' (duration: 114.41043ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:37.858497Z","caller":"traceutil/trace.go:171","msg":"trace[1685782241] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"110.640049ms","start":"2026-02-26T20:55:37.747841Z","end":"2026-02-26T20:55:37.858481Z","steps":["trace[1685782241] 'process raft request' (duration: 110.549949ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:38.250895Z","caller":"traceutil/trace.go:171","msg":"trace[684151379] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"122.095345ms","start":"2026-02-26T20:55:38.128769Z","end":"2026-02-26T20:55:38.250864Z","steps":["trace[684151379] 'process raft request' (duration: 121.900884ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:39.188374Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296565343161527648,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T20:55:39.688962Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296565343161527648,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T20:55:39.789313Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.101658885s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T20:55:39.789746Z","caller":"traceutil/trace.go:171","msg":"trace[188616394] linearizableReadLoop","detail":"{readStateIndex:520; appliedIndex:519; }","duration":"1.101949777s","start":"2026-02-26T20:55:38.68777Z","end":"2026-02-26T20:55:39.78972Z","steps":["trace[188616394] 'read index received' (duration: 1.101715455s)","trace[188616394] 'applied index is now lower than readState.Index' (duration: 232.952µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:55:39.789857Z","caller":"traceutil/trace.go:171","msg":"trace[107105346] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"1.10229365s","start":"2026-02-26T20:55:38.68755Z","end":"2026-02-26T20:55:39.789844Z","steps":["trace[107105346] 'process raft request' (duration: 1.101987408s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:39.789988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:38.687526Z","time spent":"1.10236807s","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T20:55:39.790016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.91288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T20:55:39.79008Z","caller":"traceutil/trace.go:171","msg":"trace[1727736266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:501; }","duration":"438.998641ms","start":"2026-02-26T20:55:39.351053Z","end":"2026-02-26T20:55:39.790052Z","steps":["trace[1727736266] 'agreement among raft nodes before linearized reading' (duration: 438.835719ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:39.790116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:39.351036Z","time spent":"439.071891ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T20:55:39.790165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.846326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-26T20:55:39.790179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.10237745s","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-26T20:55:39.790225Z","caller":"traceutil/trace.go:171","msg":"trace[1491282737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:501; }","duration":"374.942417ms","start":"2026-02-26T20:55:39.415265Z","end":"2026-02-26T20:55:39.790207Z","steps":["trace[1491282737] 'agreement among raft nodes before linearized reading' (duration: 374.758815ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:39.790255Z","caller":"traceutil/trace.go:171","msg":"trace[1444402562] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:501; }","duration":"1.102490871s","start":"2026-02-26T20:55:38.687744Z","end":"2026-02-26T20:55:39.790235Z","steps":["trace[1444402562] 'agreement among raft nodes before linearized reading' (duration: 1.102204419s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:39.790271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:39.415245Z","time spent":"375.015298ms","remote":"127.0.0.1:41848","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-26T20:55:39.790302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:38.687735Z","time spent":"1.102558291s","remote":"127.0.0.1:41848","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":"warn","ts":"2026-02-26T20:55:40.168415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.557424ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T20:55:40.168654Z","caller":"traceutil/trace.go:171","msg":"trace[812952692] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"373.902032ms","start":"2026-02-26T20:55:39.794717Z","end":"2026-02-26T20:55:40.168619Z","steps":["trace[812952692] 'process raft request' (duration: 96.050585ms)","trace[812952692] 'compare' (duration: 276.548237ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:55:40.168811Z","caller":"traceutil/trace.go:171","msg":"trace[1042841185] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"373.940122ms","start":"2026-02-26T20:55:39.794856Z","end":"2026-02-26T20:55:40.168796Z","steps":["trace[1042841185] 'process raft request' (duration: 373.68176ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:40.168813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:39.7947Z","time spent":"374.028702ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T20:55:40.168866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:39.794832Z","time spent":"374.010222ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T20:55:40.168956Z","caller":"traceutil/trace.go:171","msg":"trace[635503129] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:520; }","duration":"193.677545ms","start":"2026-02-26T20:55:39.975262Z","end":"2026-02-26T20:55:40.168939Z","steps":["trace[635503129] 'read index received' (duration: 191.691719ms)","trace[635503129] 'applied index is now lower than readState.Index' (duration: 1.984576ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:55:40.169008Z","caller":"traceutil/trace.go:171","msg":"trace[909320979] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"374.138093ms","start":"2026-02-26T20:55:39.794865Z","end":"2026-02-26T20:55:40.169003Z","steps":["trace[909320979] 'process raft request' (duration: 373.788391ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:40.169036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:39.794837Z","time spent":"374.183634ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T20:55:40.169041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.785286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T20:55:40.169081Z","caller":"traceutil/trace.go:171","msg":"trace[1623676349] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:504; }","duration":"193.871127ms","start":"2026-02-26T20:55:39.975195Z","end":"2026-02-26T20:55:40.169066Z","steps":["trace[1623676349] 'agreement among raft nodes before linearized reading' (duration: 193.808926ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:45.146553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.170977515s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T20:55:45.146591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.654131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-26T20:55:45.146652Z","caller":"traceutil/trace.go:171","msg":"trace[2054099677] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:512; }","duration":"957.812253ms","start":"2026-02-26T20:55:44.188825Z","end":"2026-02-26T20:55:45.146637Z","steps":["trace[2054099677] 'range keys from in-memory index tree' (duration: 957.46991ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:45.146649Z","caller":"traceutil/trace.go:171","msg":"trace[1365189522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"1.171123986s","start":"2026-02-26T20:55:43.975506Z","end":"2026-02-26T20:55:45.14663Z","steps":["trace[1365189522] 'range keys from in-memory index tree' (duration: 1.170891635s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:45.146677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:44.188799Z","time spent":"957.871373ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-26T20:55:45.146685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:43.975488Z","time spent":"1.171190406s","remote":"127.0.0.1:41562","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-26T20:55:45.146755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.649059ms","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-26T20:55:45.146798Z","caller":"traceutil/trace.go:171","msg":"trace[1617563487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:512; }","duration":"958.728479ms","start":"2026-02-26T20:55:44.18806Z","end":"2026-02-26T20:55:45.146789Z","steps":["trace[1617563487] 'range keys from in-memory index tree' (duration: 958.562258ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:45.14682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:44.188043Z","time spent":"958.770099ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T20:55:45.146743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.603037497s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7gdnw\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-02-26T20:55:45.146887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.585469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-26T20:55:45.146909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346975449s","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-26T20:55:45.146928Z","caller":"traceutil/trace.go:171","msg":"trace[455366547] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:512; }","duration":"1.347025699s","start":"2026-02-26T20:55:43.799897Z","end":"2026-02-26T20:55:45.146922Z","steps":["trace[455366547] 'range keys from in-memory index tree' (duration: 1.346861037s)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:45.146927Z","caller":"traceutil/trace.go:171","msg":"trace[1716260309] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7gdnw; range_end:; response_count:1; response_revision:512; }","duration":"1.603255749s","start":"2026-02-26T20:55:43.543653Z","end":"2026-02-26T20:55:45.146909Z","steps":["trace[1716260309] 'range keys from in-memory index tree' (duration: 1.602898277s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:45.146943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:43.799883Z","time spent":"1.347055169s","remote":"127.0.0.1:41848","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":"info","ts":"2026-02-26T20:55:45.146936Z","caller":"traceutil/trace.go:171","msg":"trace[801497712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:512; }","duration":"958.679999ms","start":"2026-02-26T20:55:44.188237Z","end":"2026-02-26T20:55:45.146917Z","steps":["trace[801497712] 'range keys from in-memory index tree' (duration: 958.362286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:45.146971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:44.188206Z","time spent":"958.755589ms","remote":"127.0.0.1:41848","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-26T20:55:45.146967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:43.543638Z","time spent":"1.603316539s","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-7gdnw\" "} {"level":"warn","ts":"2026-02-26T20:55:45.653815Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296565343161527681,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T20:55:45.982671Z","caller":"traceutil/trace.go:171","msg":"trace[865049469] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"832.600138ms","start":"2026-02-26T20:55:45.150041Z","end":"2026-02-26T20:55:45.982641Z","steps":["trace[865049469] 'process raft request' (duration: 832.448747ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:45.982841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:45.150026Z","time spent":"832.719199ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T20:55:46.753815Z","caller":"traceutil/trace.go:171","msg":"trace[489249360] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:532; }","duration":"1.600277395s","start":"2026-02-26T20:55:45.15352Z","end":"2026-02-26T20:55:46.753797Z","steps":["trace[489249360] 'read index received' (duration: 828.91144ms)","trace[489249360] 'applied index is now lower than readState.Index' (duration: 771.365315ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T20:55:46.753913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.600377596s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T20:55:46.753935Z","caller":"traceutil/trace.go:171","msg":"trace[1397122833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:517; }","duration":"1.600428866s","start":"2026-02-26T20:55:45.153499Z","end":"2026-02-26T20:55:46.753928Z","steps":["trace[1397122833] 'agreement among raft nodes before linearized reading' (duration: 1.600362186s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:46.753956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:45.153493Z","time spent":"1.600458546s","remote":"127.0.0.1:41578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-26T20:55:46.754016Z","caller":"traceutil/trace.go:171","msg":"trace[2025276511] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.594051658s","start":"2026-02-26T20:55:45.159953Z","end":"2026-02-26T20:55:46.754005Z","steps":["trace[2025276511] 'process raft request' (duration: 1.593806346s)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:46.754092Z","caller":"traceutil/trace.go:171","msg":"trace[1196217160] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.603141067s","start":"2026-02-26T20:55:45.150351Z","end":"2026-02-26T20:55:46.753492Z","steps":["trace[1196217160] 'process raft request' (duration: 1.602936556s)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:46.753908Z","caller":"traceutil/trace.go:171","msg":"trace[1073212938] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.603159367s","start":"2026-02-26T20:55:45.150619Z","end":"2026-02-26T20:55:46.753779Z","steps":["trace[1073212938] 'process raft request' (duration: 1.602800635s)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:46.754144Z","caller":"traceutil/trace.go:171","msg":"trace[1780616807] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.603210636s","start":"2026-02-26T20:55:45.150883Z","end":"2026-02-26T20:55:46.754094Z","steps":["trace[1780616807] 'process raft request' (duration: 1.602804584s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:46.754163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:45.159941Z","time spent":"1.594131318s","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T20:55:46.754293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:45.150878Z","time spent":"1.603325617s","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T20:55:46.754293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:45.150345Z","time spent":"1.603868992s","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T20:55:46.754307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:45.150614Z","time spent":"1.60357922s","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T20:55:47.679595Z","caller":"traceutil/trace.go:171","msg":"trace[987564082] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"627.495801ms","start":"2026-02-26T20:55:47.05208Z","end":"2026-02-26T20:55:47.679576Z","steps":["trace[987564082] 'process raft request' (duration: 627.369001ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:47.679713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:47.052055Z","time spent":"627.593492ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T20:55:48.47649Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296565343161527691,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T20:55:48.790078Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.06735037s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-26T20:55:49.044878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.63764ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-02-26T20:55:49.044988Z","caller":"traceutil/trace.go:171","msg":"trace[1769565175] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:538; }","duration":"1.069201364s","start":"2026-02-26T20:55:47.975768Z","end":"2026-02-26T20:55:49.04497Z","steps":["trace[1769565175] 'read index received' (duration: 814.444363ms)","trace[1769565175] 'applied index is now lower than readState.Index' (duration: 254.755331ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T20:55:49.045088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:47.722591Z","time spent":"1.322494243s","remote":"127.0.0.1:41616","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-26T20:55:49.04549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.069711658s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T20:55:49.045533Z","caller":"traceutil/trace.go:171","msg":"trace[945899069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"1.069790828s","start":"2026-02-26T20:55:47.975731Z","end":"2026-02-26T20:55:49.045522Z","steps":["trace[945899069] 'agreement among raft nodes before linearized reading' (duration: 1.069716228s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:49.04552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.402718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-26T20:55:49.045521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.0581085s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-02-26T20:55:49.045569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:47.975714Z","time spent":"1.069848128s","remote":"127.0.0.1:41578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-26T20:55:49.045601Z","caller":"traceutil/trace.go:171","msg":"trace[1255192249] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:518; }","duration":"1.058219892s","start":"2026-02-26T20:55:47.987363Z","end":"2026-02-26T20:55:49.045583Z","steps":["trace[1255192249] 'agreement among raft nodes before linearized reading' (duration: 1.05796911s)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:49.045606Z","caller":"traceutil/trace.go:171","msg":"trace[1999563111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:518; }","duration":"286.508609ms","start":"2026-02-26T20:55:48.759063Z","end":"2026-02-26T20:55:49.045572Z","steps":["trace[1999563111] 'agreement among raft nodes before linearized reading' (duration: 286.297467ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:49.045632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.003314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-26T20:55:49.045651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:47.987352Z","time spent":"1.058291612s","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-26T20:55:49.045689Z","caller":"traceutil/trace.go:171","msg":"trace[1796999724] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"287.059564ms","start":"2026-02-26T20:55:48.758612Z","end":"2026-02-26T20:55:49.045671Z","steps":["trace[1796999724] 'agreement among raft nodes before linearized reading' (duration: 286.893003ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:49.045527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.186896ms","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-26T20:55:49.045765Z","caller":"traceutil/trace.go:171","msg":"trace[1132682251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"286.476529ms","start":"2026-02-26T20:55:48.759279Z","end":"2026-02-26T20:55:49.045755Z","steps":["trace[1132682251] 'agreement among raft nodes before linearized reading' (duration: 286.091556ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:49.421768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.253434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T20:55:49.421919Z","caller":"traceutil/trace.go:171","msg":"trace[1107969575] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"375.455084ms","start":"2026-02-26T20:55:49.046432Z","end":"2026-02-26T20:55:49.421888Z","steps":["trace[1107969575] 'process raft request' (duration: 206.018769ms)","trace[1107969575] 'compare' (duration: 169.151573ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:55:49.422005Z","caller":"traceutil/trace.go:171","msg":"trace[1300893555] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"358.388497ms","start":"2026-02-26T20:55:49.063603Z","end":"2026-02-26T20:55:49.421992Z","steps":["trace[1300893555] 'process raft request' (duration: 358.363117ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:49.421997Z","caller":"traceutil/trace.go:171","msg":"trace[1333271866] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:539; }","duration":"361.919704ms","start":"2026-02-26T20:55:49.060042Z","end":"2026-02-26T20:55:49.421962Z","steps":["trace[1333271866] 'read index received' (duration: 192.274127ms)","trace[1333271866] 'applied index is now lower than readState.Index' (duration: 169.640327ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T20:55:49.422054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:49.063591Z","time spent":"358.440617ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T20:55:49.42206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:49.046401Z","time spent":"375.584046ms","remote":"127.0.0.1:41616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T20:55:49.422081Z","caller":"traceutil/trace.go:171","msg":"trace[1721132867] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"359.766798ms","start":"2026-02-26T20:55:49.062272Z","end":"2026-02-26T20:55:49.422039Z","steps":["trace[1721132867] 'process raft request' (duration: 359.597766ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:49.422166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.096065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T20:55:49.422179Z","caller":"traceutil/trace.go:171","msg":"trace[551257163] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"359.874158ms","start":"2026-02-26T20:55:49.062289Z","end":"2026-02-26T20:55:49.422164Z","steps":["trace[551257163] 'process raft request' (duration: 359.632537ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:55:49.422192Z","caller":"traceutil/trace.go:171","msg":"trace[809131494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"362.164446ms","start":"2026-02-26T20:55:49.06002Z","end":"2026-02-26T20:55:49.422184Z","steps":["trace[809131494] 'agreement among raft nodes before linearized reading' (duration: 362.028345ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:49.422222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:49.060005Z","time spent":"362.210276ms","remote":"127.0.0.1:41578","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-26T20:55:49.422234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:49.062273Z","time spent":"359.929749ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T20:55:49.422289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:49.062254Z","time spent":"359.926429ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T20:55:49.422286Z","caller":"traceutil/trace.go:171","msg":"trace[1862211337] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"359.253023ms","start":"2026-02-26T20:55:49.062995Z","end":"2026-02-26T20:55:49.422248Z","steps":["trace[1862211337] 'process raft request' (duration: 358.949151ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:49.422546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:49.062988Z","time spent":"359.384965ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T20:55:51.068015Z","caller":"traceutil/trace.go:171","msg":"trace[1934752420] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"306.800221ms","start":"2026-02-26T20:55:50.761184Z","end":"2026-02-26T20:55:51.067984Z","steps":["trace[1934752420] 'process raft request' (duration: 305.095198ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:55:51.068205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:55:50.761161Z","time spent":"306.928782ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T20:55:53.870248Z","caller":"traceutil/trace.go:171","msg":"trace[15897551] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"149.76585ms","start":"2026-02-26T20:55:53.720455Z","end":"2026-02-26T20:55:53.870221Z","steps":["trace[15897551] 'process raft request' (duration: 149.604668ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:56:01.325581Z","caller":"traceutil/trace.go:171","msg":"trace[1930088483] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"128.991813ms","start":"2026-02-26T20:56:01.19657Z","end":"2026-02-26T20:56:01.325562Z","steps":["trace[1930088483] 'process raft request' (duration: 128.875308ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:56:01.358878Z","caller":"traceutil/trace.go:171","msg":"trace[1629040282] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"160.940927ms","start":"2026-02-26T20:56:01.197906Z","end":"2026-02-26T20:56:01.358847Z","steps":["trace[1629040282] 'process raft request' (duration: 160.77194ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:56:08.405539Z","caller":"traceutil/trace.go:171","msg":"trace[793135418] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"675.316412ms","start":"2026-02-26T20:56:07.730193Z","end":"2026-02-26T20:56:08.40551Z","steps":["trace[793135418] 'process raft request' (duration: 668.33504ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:56:08.405707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:07.730169Z","time spent":"675.455007ms","remote":"127.0.0.1:41848","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-26T20:56:08.406506Z","caller":"traceutil/trace.go:171","msg":"trace[746700162] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"387.336945ms","start":"2026-02-26T20:56:08.019142Z","end":"2026-02-26T20:56:08.406479Z","steps":["trace[746700162] 'process raft request' (duration: 387.215471ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:56:08.406751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:08.019118Z","time spent":"387.528052ms","remote":"127.0.0.1:41616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T20:56:13.680619Z","caller":"traceutil/trace.go:171","msg":"trace[1419666763] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"110.058833ms","start":"2026-02-26T20:56:13.570534Z","end":"2026-02-26T20:56:13.680593Z","steps":["trace[1419666763] 'process raft request' (duration: 109.866997ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:56:13.680963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.24601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-26T20:56:13.680711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.835548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T20:56:13.681041Z","caller":"traceutil/trace.go:171","msg":"trace[849690151] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:736; }","duration":"110.330973ms","start":"2026-02-26T20:56:13.570685Z","end":"2026-02-26T20:56:13.681016Z","steps":["trace[849690151] 'agreement among raft nodes before linearized reading' (duration: 110.115125ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:56:13.681216Z","caller":"traceutil/trace.go:171","msg":"trace[1517423638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:736; }","duration":"113.357156ms","start":"2026-02-26T20:56:13.567812Z","end":"2026-02-26T20:56:13.681169Z","steps":["trace[1517423638] 'agreement among raft nodes before linearized reading' (duration: 112.723184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:56:15.791534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.958401ms","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-26T20:56:15.791615Z","caller":"traceutil/trace.go:171","msg":"trace[155379702] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:739; }","duration":"129.052674ms","start":"2026-02-26T20:56:15.662544Z","end":"2026-02-26T20:56:15.791597Z","steps":["trace[155379702] 'range keys from in-memory index tree' (duration: 128.787125ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:56:15.791687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.615134ms","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-26T20:56:15.791771Z","caller":"traceutil/trace.go:171","msg":"trace[643884031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:739; }","duration":"105.750598ms","start":"2026-02-26T20:56:15.685998Z","end":"2026-02-26T20:56:15.791748Z","steps":["trace[643884031] 'range keys from in-memory index tree' (duration: 105.436978ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:56:56.408967Z","caller":"traceutil/trace.go:171","msg":"trace[68945844] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"102.655834ms","start":"2026-02-26T20:56:56.306288Z","end":"2026-02-26T20:56:56.408944Z","steps":["trace[68945844] 'process raft request' (duration: 102.49233ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:56:56.558514Z","caller":"traceutil/trace.go:171","msg":"trace[709051262] linearizableReadLoop","detail":"{readStateIndex:892; appliedIndex:890; }","duration":"208.180475ms","start":"2026-02-26T20:56:56.350308Z","end":"2026-02-26T20:56:56.558488Z","steps":["trace[709051262] 'read index received' (duration: 58.550359ms)","trace[709051262] 'applied index is now lower than readState.Index' (duration: 149.629056ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:56:56.558671Z","caller":"traceutil/trace.go:171","msg":"trace[1893470761] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"249.913777ms","start":"2026-02-26T20:56:56.308721Z","end":"2026-02-26T20:56:56.558635Z","steps":["trace[1893470761] 'process raft request' (duration: 244.974526ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:56:56.558781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.255699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"} {"level":"warn","ts":"2026-02-26T20:56:56.558807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.460311ms","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-26T20:56:56.558875Z","caller":"traceutil/trace.go:171","msg":"trace[822133207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:854; }","duration":"208.590803ms","start":"2026-02-26T20:56:56.350269Z","end":"2026-02-26T20:56:56.55886Z","steps":["trace[822133207] 'agreement among raft nodes before linearized reading' (duration: 208.361028ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:56:56.558826Z","caller":"traceutil/trace.go:171","msg":"trace[431584442] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:854; }","duration":"180.361802ms","start":"2026-02-26T20:56:56.378452Z","end":"2026-02-26T20:56:56.558814Z","steps":["trace[431584442] 'agreement among raft nodes before linearized reading' (duration: 180.167938ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:57:02.350945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.440767ms","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-26T20:57:02.351098Z","caller":"traceutil/trace.go:171","msg":"trace[1505782196] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:877; }","duration":"404.639212ms","start":"2026-02-26T20:57:01.946443Z","end":"2026-02-26T20:57:02.351082Z","steps":["trace[1505782196] 'range keys from in-memory index tree' (duration: 404.294774ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:57:02.351152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:01.946425Z","time spent":"404.717363ms","remote":"127.0.0.1:41848","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-26T20:57:02.35144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.118811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-26T20:57:02.351522Z","caller":"traceutil/trace.go:171","msg":"trace[1643514533] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:877; }","duration":"142.234934ms","start":"2026-02-26T20:57:02.209266Z","end":"2026-02-26T20:57:02.351501Z","steps":["trace[1643514533] 'range keys from in-memory index tree' (duration: 141.983308ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:57:02.35144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.299459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-02-26T20:57:02.351609Z","caller":"traceutil/trace.go:171","msg":"trace[1223163082] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:877; }","duration":"265.507864ms","start":"2026-02-26T20:57:02.086079Z","end":"2026-02-26T20:57:02.351587Z","steps":["trace[1223163082] 'range keys from in-memory index tree' (duration: 265.114125ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:57:02.351922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.283016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T20:57:02.351973Z","caller":"traceutil/trace.go:171","msg":"trace[261338807] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:877; }","duration":"246.341757ms","start":"2026-02-26T20:57:02.105619Z","end":"2026-02-26T20:57:02.351961Z","steps":["trace[261338807] 'count revisions from in-memory index tree' (duration: 246.229165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:57:02.757608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.766622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T20:57:02.757686Z","caller":"traceutil/trace.go:171","msg":"trace[159676648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:880; }","duration":"171.895965ms","start":"2026-02-26T20:57:02.58577Z","end":"2026-02-26T20:57:02.757666Z","steps":["trace[159676648] 'range keys from in-memory index tree' (duration: 171.604908ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:57:02.757925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.384968ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T20:57:02.758317Z","caller":"traceutil/trace.go:171","msg":"trace[1274275028] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:880; }","duration":"199.084542ms","start":"2026-02-26T20:57:02.559209Z","end":"2026-02-26T20:57:02.758294Z","steps":["trace[1274275028] 'range keys from in-memory index tree' (duration: 198.339026ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:57:02.894828Z","caller":"traceutil/trace.go:171","msg":"trace[685513624] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"132.265904ms","start":"2026-02-26T20:57:02.762544Z","end":"2026-02-26T20:57:02.89481Z","steps":["trace[685513624] 'process raft request' (duration: 132.127891ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:57:02.898081Z","caller":"traceutil/trace.go:171","msg":"trace[1091879487] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"135.063375ms","start":"2026-02-26T20:57:02.762998Z","end":"2026-02-26T20:57:02.898061Z","steps":["trace[1091879487] 'process raft request' (duration: 134.4018ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:57:02.898143Z","caller":"traceutil/trace.go:171","msg":"trace[1315485513] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"133.778707ms","start":"2026-02-26T20:57:02.764321Z","end":"2026-02-26T20:57:02.8981Z","steps":["trace[1315485513] 'process raft request' (duration: 133.282965ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:57:04.514223Z","caller":"traceutil/trace.go:171","msg":"trace[340734777] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"115.886315ms","start":"2026-02-26T20:57:04.398314Z","end":"2026-02-26T20:57:04.514201Z","steps":["trace[340734777] 'process raft request' (duration: 115.557838ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:57:04.663826Z","caller":"traceutil/trace.go:171","msg":"trace[275165911] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"145.202047ms","start":"2026-02-26T20:57:04.51859Z","end":"2026-02-26T20:57:04.663792Z","steps":["trace[275165911] 'process raft request' (duration: 78.046293ms)","trace[275165911] 'compare' (duration: 66.886158ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T20:57:04.664324Z","caller":"traceutil/trace.go:171","msg":"trace[1844391305] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"145.473133ms","start":"2026-02-26T20:57:04.518839Z","end":"2026-02-26T20:57:04.664312Z","steps":["trace[1844391305] 'process raft request' (duration: 144.891371ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:57:08.138779Z","caller":"traceutil/trace.go:171","msg":"trace[96700859] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"124.159806ms","start":"2026-02-26T20:57:08.014584Z","end":"2026-02-26T20:57:08.138743Z","steps":["trace[96700859] 'process raft request' (duration: 123.909941ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:57:18.811523Z","caller":"traceutil/trace.go:171","msg":"trace[1067789973] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"139.141618ms","start":"2026-02-26T20:57:18.672349Z","end":"2026-02-26T20:57:18.81149Z","steps":["trace[1067789973] 'process raft request' (duration: 138.921054ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:57:19.198397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.609321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T20:57:19.198496Z","caller":"traceutil/trace.go:171","msg":"trace[2129120812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:952; }","duration":"224.743064ms","start":"2026-02-26T20:57:18.973715Z","end":"2026-02-26T20:57:19.198458Z","steps":["trace[2129120812] 'range keys from in-memory index tree' (duration: 224.53707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:57:19.198797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.35047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-26T20:57:19.198784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.456914ms","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-26T20:57:19.198847Z","caller":"traceutil/trace.go:171","msg":"trace[316185062] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:952; }","duration":"340.400301ms","start":"2026-02-26T20:57:18.858433Z","end":"2026-02-26T20:57:19.198834Z","steps":["trace[316185062] 'range keys from in-memory index tree' (duration: 340.218547ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:57:19.198857Z","caller":"traceutil/trace.go:171","msg":"trace[1426081652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:952; }","duration":"148.579568ms","start":"2026-02-26T20:57:19.05026Z","end":"2026-02-26T20:57:19.198839Z","steps":["trace[1426081652] 'range keys from in-memory index tree' (duration: 148.263329ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:57:19.198876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:18.858375Z","time spent":"340.491422ms","remote":"127.0.0.1:41848","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-26T20:57:19.198947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.920512ms","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-26T20:57:19.199017Z","caller":"traceutil/trace.go:171","msg":"trace[290436362] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:952; }","duration":"322.990094ms","start":"2026-02-26T20:57:18.876013Z","end":"2026-02-26T20:57:19.199004Z","steps":["trace[290436362] 'range keys from in-memory index tree' (duration: 322.336271ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T20:57:19.199621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:18.875957Z","time spent":"323.651726ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-26T20:57:19.341498Z","caller":"traceutil/trace.go:171","msg":"trace[576631643] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"138.61699ms","start":"2026-02-26T20:57:19.202851Z","end":"2026-02-26T20:57:19.341468Z","steps":["trace[576631643] 'process raft request' (duration: 138.446617ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:57:19.341514Z","caller":"traceutil/trace.go:171","msg":"trace[212887379] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"138.248984ms","start":"2026-02-26T20:57:19.203247Z","end":"2026-02-26T20:57:19.341496Z","steps":["trace[212887379] 'process raft request' (duration: 138.180982ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T20:57:19.341808Z","caller":"traceutil/trace.go:171","msg":"trace[1598645091] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"138.181142ms","start":"2026-02-26T20:57:19.203467Z","end":"2026-02-26T20:57:19.341648Z","steps":["trace[1598645091] 'process raft request' (duration: 137.997409ms)"],"step_count":1}