{"level":"warn","ts":"2026-03-14T06:57:57.669069Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-14T06:57:57.669165Z","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-03-14T06:57:57.669686Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-14T06:57:57.669704Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-03-14T06:57:57.669733Z","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-03-14T06:57:57.670607Z","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-03-14T06:57:57.670702Z","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-03-14T06:57:57.67793Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.969531ms"} {"level":"info","ts":"2026-03-14T06:57:57.690421Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-03-14T06:57:57.690481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-03-14T06:57:57.690499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-03-14T06:57:57.690513Z","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-03-14T06:57:57.690522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-03-14T06:57:57.690555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-03-14T06:57:57.698791Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-14T06:57:57.699961Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-14T06:57:57.700989Z","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-03-14T06:57:57.703233Z","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-03-14T06:57:57.703533Z","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-03-14T06:57:57.704Z","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-03-14T06:57:57.704493Z","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-03-14T06:57:57.704579Z","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-03-14T06:57:57.705485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-03-14T06:57:57.705873Z","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-03-14T06:57:57.709212Z","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-03-14T06:57:57.709363Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-03-14T06:57:57.709409Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-03-14T06:57:57.709799Z","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-03-14T06:57:57.709863Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-14T06:57:57.791466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-03-14T06:57:57.791564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-03-14T06:57:57.791604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-03-14T06:57:57.791655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-03-14T06:57:57.791675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-03-14T06:57:57.791693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-03-14T06:57:57.79172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-03-14T06:57:57.792722Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-14T06:57:57.793472Z","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-03-14T06:57:57.793635Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-14T06:57:57.793674Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-14T06:57:57.793796Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-14T06:57:57.793842Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-14T06:57:57.79406Z","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-03-14T06:57:57.794243Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-14T06:57:57.794285Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-14T06:57:57.797372Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-03-14T06:57:57.797454Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-14T06:58:26.347547Z","caller":"traceutil/trace.go:171","msg":"trace[558911863] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"419.316544ms","start":"2026-03-14T06:58:25.928206Z","end":"2026-03-14T06:58:26.347523Z","steps":["trace[558911863] 'read index received' (duration: 419.071032ms)","trace[558911863] 'applied index is now lower than readState.Index' (duration: 244.402µs)"],"step_count":2} {"level":"info","ts":"2026-03-14T06:58:26.347678Z","caller":"traceutil/trace.go:171","msg":"trace[1802049454] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"431.052932ms","start":"2026-03-14T06:58:25.916588Z","end":"2026-03-14T06:58:26.347641Z","steps":["trace[1802049454] 'process raft request' (duration: 430.667109ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:26.347801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.528466ms","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-03-14T06:58:26.347984Z","caller":"traceutil/trace.go:171","msg":"trace[497320491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:468; }","duration":"419.809758ms","start":"2026-03-14T06:58:25.928161Z","end":"2026-03-14T06:58:26.347971Z","steps":["trace[497320491] 'agreement among raft nodes before linearized reading' (duration: 419.528685ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:26.348073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:25.928146Z","time spent":"419.913078ms","remote":"127.0.0.1:50084","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-03-14T06:58:26.348517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:25.916565Z","time spent":"431.194653ms","remote":"127.0.0.1:50084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-14T06:58:26.351474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.90743ms","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-03-14T06:58:26.351507Z","caller":"traceutil/trace.go:171","msg":"trace[398573575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:468; }","duration":"418.9827ms","start":"2026-03-14T06:58:25.932517Z","end":"2026-03-14T06:58:26.351499Z","steps":["trace[398573575] 'agreement among raft nodes before linearized reading' (duration: 418.913339ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:26.351541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:25.932496Z","time spent":"419.040021ms","remote":"127.0.0.1:50084","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-03-14T06:58:26.351682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.925336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4374"} {"level":"info","ts":"2026-03-14T06:58:26.351762Z","caller":"traceutil/trace.go:171","msg":"trace[1964016425] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:468; }","duration":"238.069847ms","start":"2026-03-14T06:58:26.113673Z","end":"2026-03-14T06:58:26.351743Z","steps":["trace[1964016425] 'agreement among raft nodes before linearized reading' (duration: 237.964696ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:32.052644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.322527ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-14T06:58:32.052734Z","caller":"traceutil/trace.go:171","msg":"trace[23232962] linearizableReadLoop","detail":"{readStateIndex:520; appliedIndex:519; }","duration":"611.785293ms","start":"2026-03-14T06:58:31.440935Z","end":"2026-03-14T06:58:32.05272Z","steps":["trace[23232962] 'read index received' (duration: 489.035472ms)","trace[23232962] 'applied index is now lower than readState.Index' (duration: 122.748371ms)"],"step_count":2} {"level":"warn","ts":"2026-03-14T06:58:32.052829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.897024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-14T06:58:32.052823Z","caller":"traceutil/trace.go:171","msg":"trace[2044643282] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"782.466226ms","start":"2026-03-14T06:58:31.270313Z","end":"2026-03-14T06:58:32.052779Z","steps":["trace[2044643282] 'process raft request' (duration: 659.706295ms)","trace[2044643282] 'compare' (duration: 121.918594ms)"],"step_count":2} {"level":"info","ts":"2026-03-14T06:58:32.05287Z","caller":"traceutil/trace.go:171","msg":"trace[35594022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:504; }","duration":"611.964484ms","start":"2026-03-14T06:58:31.440896Z","end":"2026-03-14T06:58:32.05286Z","steps":["trace[35594022] 'agreement among raft nodes before linearized reading' (duration: 611.868504ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:32.052905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:31.440881Z","time spent":"612.016985ms","remote":"127.0.0.1:57314","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-03-14T06:58:32.052964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:31.270292Z","time spent":"782.600418ms","remote":"127.0.0.1:57340","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-03-14T06:58:32.613043Z","caller":"traceutil/trace.go:171","msg":"trace[446487644] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"211.70705ms","start":"2026-03-14T06:58:32.401311Z","end":"2026-03-14T06:58:32.613018Z","steps":["trace[446487644] 'process raft request' (duration: 211.535079ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:32.906691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.835942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-14T06:58:32.906793Z","caller":"traceutil/trace.go:171","msg":"trace[1995806] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:523; }","duration":"465.643314ms","start":"2026-03-14T06:58:32.441131Z","end":"2026-03-14T06:58:32.906774Z","steps":["trace[1995806] 'read index received' (duration: 171.729895ms)","trace[1995806] 'applied index is now lower than readState.Index' (duration: 293.911509ms)"],"step_count":2} {"level":"info","ts":"2026-03-14T06:58:32.906862Z","caller":"traceutil/trace.go:171","msg":"trace[566025774] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"503.830845ms","start":"2026-03-14T06:58:32.403021Z","end":"2026-03-14T06:58:32.906852Z","steps":["trace[566025774] 'process raft request' (duration: 291.749541ms)","trace[566025774] 'compare' (duration: 211.725771ms)"],"step_count":2} {"level":"warn","ts":"2026-03-14T06:58:32.906921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:32.403008Z","time spent":"503.884445ms","remote":"127.0.0.1:50084","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-03-14T06:58:32.906925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.762055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-14T06:58:32.907002Z","caller":"traceutil/trace.go:171","msg":"trace[1785023833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"465.874606ms","start":"2026-03-14T06:58:32.441109Z","end":"2026-03-14T06:58:32.906983Z","steps":["trace[1785023833] 'agreement among raft nodes before linearized reading' (duration: 465.757475ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:32.907045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:32.4411Z","time spent":"465.936836ms","remote":"127.0.0.1:57314","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-03-14T06:58:33.239129Z","caller":"traceutil/trace.go:171","msg":"trace[304606439] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"475.081864ms","start":"2026-03-14T06:58:32.764021Z","end":"2026-03-14T06:58:33.239103Z","steps":["trace[304606439] 'process raft request' (duration: 474.934923ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:33.239302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:32.763994Z","time spent":"475.212355ms","remote":"127.0.0.1:50084","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-03-14T06:58:33.305485Z","caller":"traceutil/trace.go:171","msg":"trace[1211068523] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:525; }","duration":"398.636ms","start":"2026-03-14T06:58:32.906818Z","end":"2026-03-14T06:58:33.305454Z","steps":["trace[1211068523] 'read index received' (duration: 332.058431ms)","trace[1211068523] 'applied index is now lower than readState.Index' (duration: 66.576279ms)"],"step_count":2} {"level":"info","ts":"2026-03-14T06:58:33.305565Z","caller":"traceutil/trace.go:171","msg":"trace[190992438] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"411.774138ms","start":"2026-03-14T06:58:32.893763Z","end":"2026-03-14T06:58:33.305538Z","steps":["trace[190992438] 'process raft request' (duration: 411.560426ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:33.305655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.99692ms","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-03-14T06:58:33.30567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:32.893739Z","time spent":"411.878379ms","remote":"127.0.0.1:57470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4744,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-14T06:58:33.3057Z","caller":"traceutil/trace.go:171","msg":"trace[1909854068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"855.103961ms","start":"2026-03-14T06:58:32.450585Z","end":"2026-03-14T06:58:33.305689Z","steps":["trace[1909854068] 'agreement among raft nodes before linearized reading' (duration: 854.97939ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:33.305788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:32.450563Z","time spent":"855.213542ms","remote":"127.0.0.1:50084","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-03-14T06:58:33.305876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.364904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ds89k\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-03-14T06:58:33.305926Z","caller":"traceutil/trace.go:171","msg":"trace[1888400092] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ds89k; range_end:; response_count:1; response_revision:511; }","duration":"764.449265ms","start":"2026-03-14T06:58:32.541462Z","end":"2026-03-14T06:58:33.305911Z","steps":["trace[1888400092] 'agreement among raft nodes before linearized reading' (duration: 764.276364ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:33.305972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:32.541445Z","time spent":"764.518955ms","remote":"127.0.0.1:57476","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-ds89k\" "} {"level":"warn","ts":"2026-03-14T06:58:33.306155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.464335ms","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-03-14T06:58:33.306299Z","caller":"traceutil/trace.go:171","msg":"trace[650076040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:511; }","duration":"854.650327ms","start":"2026-03-14T06:58:32.451606Z","end":"2026-03-14T06:58:33.306256Z","steps":["trace[650076040] 'agreement among raft nodes before linearized reading' (duration: 854.341944ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:33.306361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:32.451594Z","time spent":"854.757358ms","remote":"127.0.0.1:50084","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":"info","ts":"2026-03-14T06:58:33.915029Z","caller":"traceutil/trace.go:171","msg":"trace[965327794] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"601.585729ms","start":"2026-03-14T06:58:33.313416Z","end":"2026-03-14T06:58:33.915002Z","steps":["trace[965327794] 'process raft request' (duration: 601.345176ms)"],"step_count":1} {"level":"info","ts":"2026-03-14T06:58:33.915183Z","caller":"traceutil/trace.go:171","msg":"trace[2129285460] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:528; }","duration":"436.434029ms","start":"2026-03-14T06:58:33.478723Z","end":"2026-03-14T06:58:33.915157Z","steps":["trace[2129285460] 'read index received' (duration: 436.050074ms)","trace[2129285460] 'applied index is now lower than readState.Index' (duration: 382.355µs)"],"step_count":2} {"level":"warn","ts":"2026-03-14T06:58:33.915203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:33.313392Z","time spent":"601.71351ms","remote":"127.0.0.1:50084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-14T06:58:33.915257Z","caller":"traceutil/trace.go:171","msg":"trace[438767946] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"597.519537ms","start":"2026-03-14T06:58:33.317728Z","end":"2026-03-14T06:58:33.915247Z","steps":["trace[438767946] 'process raft request' (duration: 597.203933ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:33.915328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:33.317711Z","time spent":"597.576307ms","remote":"127.0.0.1:57476","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-03-14T06:58:33.915385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.656211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-14T06:58:33.915416Z","caller":"traceutil/trace.go:171","msg":"trace[523658238] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:514; }","duration":"436.743733ms","start":"2026-03-14T06:58:33.478665Z","end":"2026-03-14T06:58:33.915408Z","steps":["trace[523658238] 'agreement among raft nodes before linearized reading' (duration: 436.681372ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:33.915434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:33.478639Z","time spent":"436.791873ms","remote":"127.0.0.1:57314","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-03-14T06:58:35.007723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.88071ms","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-03-14T06:58:35.007786Z","caller":"traceutil/trace.go:171","msg":"trace[2056167633] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:514; }","duration":"390.978454ms","start":"2026-03-14T06:58:34.616794Z","end":"2026-03-14T06:58:35.007772Z","steps":["trace[2056167633] 'range keys from in-memory index tree' (duration: 390.808407ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:35.007817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:34.616778Z","time spent":"391.032797ms","remote":"127.0.0.1:50084","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":"info","ts":"2026-03-14T06:58:35.443512Z","caller":"traceutil/trace.go:171","msg":"trace[840013973] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"104.735889ms","start":"2026-03-14T06:58:35.338755Z","end":"2026-03-14T06:58:35.44349Z","steps":["trace[840013973] 'process raft request' (duration: 104.321301ms)"],"step_count":1} {"level":"info","ts":"2026-03-14T06:58:36.743228Z","caller":"traceutil/trace.go:171","msg":"trace[84912645] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:545; }","duration":"136.27858ms","start":"2026-03-14T06:58:36.60692Z","end":"2026-03-14T06:58:36.743199Z","steps":["trace[84912645] 'read index received' (duration: 81.715383ms)","trace[84912645] 'applied index is now lower than readState.Index' (duration: 54.562167ms)"],"step_count":2} {"level":"warn","ts":"2026-03-14T06:58:36.74335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.412546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-14T06:58:36.743388Z","caller":"traceutil/trace.go:171","msg":"trace[483243429] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:529; }","duration":"136.491549ms","start":"2026-03-14T06:58:36.606882Z","end":"2026-03-14T06:58:36.743373Z","steps":["trace[483243429] 'agreement among raft nodes before linearized reading' (duration: 136.416486ms)"],"step_count":1} {"level":"info","ts":"2026-03-14T06:58:36.743375Z","caller":"traceutil/trace.go:171","msg":"trace[1871623536] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"154.930969ms","start":"2026-03-14T06:58:36.588405Z","end":"2026-03-14T06:58:36.743336Z","steps":["trace[1871623536] 'process raft request' (duration: 100.31816ms)","trace[1871623536] 'compare' (duration: 54.374299ms)"],"step_count":2} {"level":"info","ts":"2026-03-14T06:58:37.292144Z","caller":"traceutil/trace.go:171","msg":"trace[292577928] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"282.725612ms","start":"2026-03-14T06:58:37.00939Z","end":"2026-03-14T06:58:37.292116Z","steps":["trace[292577928] 'process raft request' (duration: 282.570776ms)"],"step_count":1} {"level":"info","ts":"2026-03-14T06:58:37.292568Z","caller":"traceutil/trace.go:171","msg":"trace[41010128] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:555; }","duration":"236.988112ms","start":"2026-03-14T06:58:37.055566Z","end":"2026-03-14T06:58:37.292555Z","steps":["trace[41010128] 'read index received' (duration: 236.382996ms)","trace[41010128] 'applied index is now lower than readState.Index' (duration: 603.806µs)"],"step_count":2} {"level":"warn","ts":"2026-03-14T06:58:37.292789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.211531ms","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-03-14T06:58:37.292827Z","caller":"traceutil/trace.go:171","msg":"trace[1412864567] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:539; }","duration":"237.294375ms","start":"2026-03-14T06:58:37.055522Z","end":"2026-03-14T06:58:37.292816Z","steps":["trace[1412864567] 'agreement among raft nodes before linearized reading' (duration: 237.171829ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:37.296248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.611237ms","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-03-14T06:58:37.296299Z","caller":"traceutil/trace.go:171","msg":"trace[953986622] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:540; }","duration":"231.721732ms","start":"2026-03-14T06:58:37.064566Z","end":"2026-03-14T06:58:37.296288Z","steps":["trace[953986622] 'agreement among raft nodes before linearized reading' (duration: 231.580556ms)"],"step_count":1} {"level":"info","ts":"2026-03-14T06:58:44.553645Z","caller":"traceutil/trace.go:171","msg":"trace[1226463540] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"598.639967ms","start":"2026-03-14T06:58:43.954981Z","end":"2026-03-14T06:58:44.553621Z","steps":["trace[1226463540] 'process raft request' (duration: 598.45713ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:44.553795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:43.954973Z","time spent":"598.746861ms","remote":"127.0.0.1:50084","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-03-14T06:58:45.761072Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.207605065s","expected-duration":"1s"} {"level":"info","ts":"2026-03-14T06:58:45.765258Z","caller":"traceutil/trace.go:171","msg":"trace[1046861036] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.50013074s","start":"2026-03-14T06:58:44.265088Z","end":"2026-03-14T06:58:45.765219Z","steps":["trace[1046861036] 'process raft request' (duration: 1.496163488s)"],"step_count":1} {"level":"info","ts":"2026-03-14T06:58:45.765345Z","caller":"traceutil/trace.go:171","msg":"trace[1187118095] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:647; }","duration":"1.322703284s","start":"2026-03-14T06:58:44.442624Z","end":"2026-03-14T06:58:45.765327Z","steps":["trace[1187118095] 'read index received' (duration: 110.883068ms)","trace[1187118095] 'applied index is now lower than readState.Index' (duration: 1.211818556s)"],"step_count":2} {"level":"warn","ts":"2026-03-14T06:58:45.765472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:44.265066Z","time spent":"1.500343667s","remote":"127.0.0.1:50502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1238,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-14T06:58:45.765538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.322897191s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-14T06:58:45.766107Z","caller":"traceutil/trace.go:171","msg":"trace[541872047] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"1.323509965s","start":"2026-03-14T06:58:44.442574Z","end":"2026-03-14T06:58:45.766084Z","steps":["trace[541872047] 'agreement among raft nodes before linearized reading' (duration: 1.322825738s)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:45.765657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.294170293s","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":"warn","ts":"2026-03-14T06:58:45.766176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:44.442552Z","time spent":"1.323610009s","remote":"127.0.0.1:57314","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-03-14T06:58:45.766226Z","caller":"traceutil/trace.go:171","msg":"trace[100466908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:630; }","duration":"1.294746835s","start":"2026-03-14T06:58:44.471445Z","end":"2026-03-14T06:58:45.766192Z","steps":["trace[100466908] 'agreement among raft nodes before linearized reading' (duration: 1.294081519s)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:45.765717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.291008ms","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-03-14T06:58:45.766312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:44.471434Z","time spent":"1.294845709s","remote":"127.0.0.1:50084","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-03-14T06:58:45.766318Z","caller":"traceutil/trace.go:171","msg":"trace[332054030] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"402.886791ms","start":"2026-03-14T06:58:45.363418Z","end":"2026-03-14T06:58:45.766304Z","steps":["trace[332054030] 'agreement among raft nodes before linearized reading' (duration: 402.165774ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:45.766461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:45.363363Z","time spent":"403.078378ms","remote":"127.0.0.1:50084","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-03-14T06:58:45.765808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.829443ms","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-03-14T06:58:45.766577Z","caller":"traceutil/trace.go:171","msg":"trace[1463885346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"287.611123ms","start":"2026-03-14T06:58:45.478948Z","end":"2026-03-14T06:58:45.766559Z","steps":["trace[1463885346] 'agreement among raft nodes before linearized reading' (duration: 286.801262ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:45.765821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.226147808s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ds89k\" ","response":"range_response_count:1 size:18709"} {"level":"info","ts":"2026-03-14T06:58:45.766738Z","caller":"traceutil/trace.go:171","msg":"trace[551665501] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ds89k; range_end:; response_count:1; response_revision:630; }","duration":"1.227085325s","start":"2026-03-14T06:58:44.539627Z","end":"2026-03-14T06:58:45.766713Z","steps":["trace[551665501] 'agreement among raft nodes before linearized reading' (duration: 1.226141549s)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:45.76679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:44.539597Z","time spent":"1.227179168s","remote":"127.0.0.1:57476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18732,"request content":"key:\"/registry/pods/kube-system/cilium-ds89k\" "} {"level":"warn","ts":"2026-03-14T06:58:45.765751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.792516ms","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-03-14T06:58:45.766893Z","caller":"traceutil/trace.go:171","msg":"trace[1238673719] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"409.95906ms","start":"2026-03-14T06:58:45.356924Z","end":"2026-03-14T06:58:45.766883Z","steps":["trace[1238673719] 'agreement among raft nodes before linearized reading' (duration: 408.759374ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T06:58:45.766933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T06:58:45.356904Z","time spent":"410.018343ms","remote":"127.0.0.1:50084","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":"info","ts":"2026-03-14T07:00:06.594066Z","caller":"traceutil/trace.go:171","msg":"trace[758133973] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"374.174633ms","start":"2026-03-14T07:00:06.219868Z","end":"2026-03-14T07:00:06.594043Z","steps":["trace[758133973] 'process raft request' (duration: 374.04201ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T07:00:06.594244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T07:00:06.219849Z","time spent":"374.292825ms","remote":"127.0.0.1:50084","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-03-14T07:00:06.594444Z","caller":"traceutil/trace.go:171","msg":"trace[1945479064] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1003; }","duration":"350.663025ms","start":"2026-03-14T07:00:06.243744Z","end":"2026-03-14T07:00:06.594407Z","steps":["trace[1945479064] 'read index received' (duration: 350.649044ms)","trace[1945479064] 'applied index is now lower than readState.Index' (duration: 11.681µs)"],"step_count":2} {"level":"warn","ts":"2026-03-14T07:00:06.594842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.069052ms","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-03-14T07:00:06.595058Z","caller":"traceutil/trace.go:171","msg":"trace[946744159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:966; }","duration":"351.301756ms","start":"2026-03-14T07:00:06.243697Z","end":"2026-03-14T07:00:06.594999Z","steps":["trace[946744159] 'agreement among raft nodes before linearized reading' (duration: 350.806947ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T07:00:06.595228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T07:00:06.243677Z","time spent":"351.50104ms","remote":"127.0.0.1:50084","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-03-14T07:00:06.700138Z","caller":"traceutil/trace.go:171","msg":"trace[1694785343] linearizableReadLoop","detail":"{readStateIndex:1004; appliedIndex:1003; }","duration":"105.590261ms","start":"2026-03-14T07:00:06.594523Z","end":"2026-03-14T07:00:06.700113Z","steps":["trace[1694785343] 'read index received' (duration: 41.555665ms)","trace[1694785343] 'applied index is now lower than readState.Index' (duration: 64.032746ms)"],"step_count":2} {"level":"info","ts":"2026-03-14T07:00:06.700231Z","caller":"traceutil/trace.go:171","msg":"trace[240682708] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"101.358851ms","start":"2026-03-14T07:00:06.598847Z","end":"2026-03-14T07:00:06.700206Z","steps":["trace[240682708] 'process raft request' (duration: 101.105127ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T07:00:06.713863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.27719ms","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-03-14T07:00:06.713918Z","caller":"traceutil/trace.go:171","msg":"trace[524134544] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:967; }","duration":"468.363451ms","start":"2026-03-14T07:00:06.24554Z","end":"2026-03-14T07:00:06.713903Z","steps":["trace[524134544] 'agreement among raft nodes before linearized reading' (duration: 454.678176ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T07:00:06.713951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T07:00:06.245528Z","time spent":"468.414711ms","remote":"127.0.0.1:50084","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-03-14T07:00:06.713861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.270757ms","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-03-14T07:00:06.714051Z","caller":"traceutil/trace.go:171","msg":"trace[319983090] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:967; }","duration":"469.490172ms","start":"2026-03-14T07:00:06.244546Z","end":"2026-03-14T07:00:06.714036Z","steps":["trace[319983090] 'agreement among raft nodes before linearized reading' (duration: 455.656224ms)"],"step_count":1} {"level":"warn","ts":"2026-03-14T07:00:06.714111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T07:00:06.244539Z","time spent":"469.560283ms","remote":"127.0.0.1:50084","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\" "}