{"level":"warn","ts":"2026-01-19T16:07:00.224742Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-19T16:07:00.224809Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.154: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.19.213.154:2380","--initial-cluster=instance=https://199.19.213.154:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.154:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.154: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-01-19T16:07:00.225391Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-19T16:07:00.225423Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.154:2380"]}
{"level":"info","ts":"2026-01-19T16:07:00.225445Z","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-01-19T16:07:00.226135Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.154:2379"]}
{"level":"info","ts":"2026-01-19T16:07:00.226253Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.154:2380"],"listen-peer-urls":["https://199.19.213.154:2380"],"advertise-client-urls":["https://199.19.213.154:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.154:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.154: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-01-19T16:07:00.229001Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.520163ms"}
{"level":"info","ts":"2026-01-19T16:07:00.303857Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f4aebb100319a62d","cluster-id":"23a505f69026554e"}
{"level":"info","ts":"2026-01-19T16:07:00.303939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d switched to configuration voters=()"}
{"level":"info","ts":"2026-01-19T16:07:00.303978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d became follower at term 0"}
{"level":"info","ts":"2026-01-19T16:07:00.304013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f4aebb100319a62d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-19T16:07:00.304023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d became follower at term 1"}
{"level":"info","ts":"2026-01-19T16:07:00.304078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d switched to configuration voters=(17631235268647953965)"}
{"level":"warn","ts":"2026-01-19T16:07:00.47359Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-19T16:07:00.491938Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-19T16:07:00.510901Z","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-01-19T16:07:00.517015Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f4aebb100319a62d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-19T16:07:00.519846Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f4aebb100319a62d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-19T16:07:00.520104Z","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-01-19T16:07:00.520187Z","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-01-19T16:07:00.520227Z","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-01-19T16:07:00.526894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d switched to configuration voters=(17631235268647953965)"}
{"level":"info","ts":"2026-01-19T16:07:00.531386Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"23a505f69026554e","local-member-id":"f4aebb100319a62d","added-peer-id":"f4aebb100319a62d","added-peer-peer-urls":["https://199.19.213.154:2380"]}
{"level":"info","ts":"2026-01-19T16:07:00.54486Z","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-01-19T16:07:00.545029Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.154:2380"}
{"level":"info","ts":"2026-01-19T16:07:00.545098Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.154:2380"}
{"level":"info","ts":"2026-01-19T16:07:00.545208Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f4aebb100319a62d","initial-advertise-peer-urls":["https://199.19.213.154:2380"],"listen-peer-urls":["https://199.19.213.154:2380"],"advertise-client-urls":["https://199.19.213.154:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.154:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-19T16:07:00.545246Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-19T16:07:01.105662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d is starting a new election at term 1"}
{"level":"info","ts":"2026-01-19T16:07:01.105714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-19T16:07:01.105879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d received MsgPreVoteResp from f4aebb100319a62d at term 1"}
{"level":"info","ts":"2026-01-19T16:07:01.105934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d became candidate at term 2"}
{"level":"info","ts":"2026-01-19T16:07:01.105962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d received MsgVoteResp from f4aebb100319a62d at term 2"}
{"level":"info","ts":"2026-01-19T16:07:01.106009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f4aebb100319a62d became leader at term 2"}
{"level":"info","ts":"2026-01-19T16:07:01.106062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f4aebb100319a62d elected leader f4aebb100319a62d at term 2"}
{"level":"info","ts":"2026-01-19T16:07:01.108944Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T16:07:01.111156Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f4aebb100319a62d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.154:2379]}","request-path":"/0/members/f4aebb100319a62d/attributes","cluster-id":"23a505f69026554e","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-19T16:07:01.115285Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-19T16:07:01.115595Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-19T16:07:01.115801Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-19T16:07:01.115824Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-19T16:07:01.118627Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.154:2379"}
{"level":"info","ts":"2026-01-19T16:07:01.126129Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-19T16:07:01.126355Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"23a505f69026554e","local-member-id":"f4aebb100319a62d","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T16:07:01.126452Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T16:07:01.126469Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-19T16:07:07.534401Z","caller":"traceutil/trace.go:171","msg":"trace[1970442744] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"333.907279ms","start":"2026-01-19T16:07:07.200471Z","end":"2026-01-19T16:07:07.534378Z","steps":["trace[1970442744] 'process raft request'  (duration: 333.748128ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:07.534885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:07.200459Z","time spent":"334.022819ms","remote":"127.0.0.1:54512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/disruption-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/disruption-controller\" value_size:126 >> failure:<>"}
{"level":"info","ts":"2026-01-19T16:07:09.789582Z","caller":"traceutil/trace.go:171","msg":"trace[87045855] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"118.251714ms","start":"2026-01-19T16:07:09.671273Z","end":"2026-01-19T16:07:09.789524Z","steps":["trace[87045855] 'process raft request'  (duration: 59.897586ms)","trace[87045855] 'compare'  (duration: 58.100087ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T16:07:09.995651Z","caller":"traceutil/trace.go:171","msg":"trace[494309340] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"156.991612ms","start":"2026-01-19T16:07:09.838621Z","end":"2026-01-19T16:07:09.995613Z","steps":["trace[494309340] 'process raft request'  (duration: 138.8687ms)","trace[494309340] 'compare'  (duration: 17.944922ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T16:07:09.995698Z","caller":"traceutil/trace.go:171","msg":"trace[1846429336] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"124.454857ms","start":"2026-01-19T16:07:09.871227Z","end":"2026-01-19T16:07:09.995682Z","steps":["trace[1846429336] 'process raft request'  (duration: 124.428237ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:09.996015Z","caller":"traceutil/trace.go:171","msg":"trace[1633790626] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"157.312314ms","start":"2026-01-19T16:07:09.838697Z","end":"2026-01-19T16:07:09.99601Z","steps":["trace[1633790626] 'process raft request'  (duration: 156.866752ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:09.99608Z","caller":"traceutil/trace.go:171","msg":"trace[99876868] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"157.313955ms","start":"2026-01-19T16:07:09.838762Z","end":"2026-01-19T16:07:09.996076Z","steps":["trace[99876868] 'process raft request'  (duration: 156.834912ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:09.996131Z","caller":"traceutil/trace.go:171","msg":"trace[1856356497] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"157.312354ms","start":"2026-01-19T16:07:09.838814Z","end":"2026-01-19T16:07:09.996127Z","steps":["trace[1856356497] 'process raft request'  (duration: 156.818312ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:09.996201Z","caller":"traceutil/trace.go:171","msg":"trace[320314405] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:319; }","duration":"143.049681ms","start":"2026-01-19T16:07:09.85314Z","end":"2026-01-19T16:07:09.99619Z","steps":["trace[320314405] 'read index received'  (duration: 9.982851ms)","trace[320314405] 'applied index is now lower than readState.Index'  (duration: 133.06565ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T16:07:09.996376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.234853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-01-19T16:07:09.996405Z","caller":"traceutil/trace.go:171","msg":"trace[230088949] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:317; }","duration":"143.307573ms","start":"2026-01-19T16:07:09.853091Z","end":"2026-01-19T16:07:09.996399Z","steps":["trace[230088949] 'agreement among raft nodes before linearized reading'  (duration: 143.200853ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:10.374109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.313237ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11974398332009305078 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-proxy-56l4g\" mod_revision:328 > success:<request_put:<key:\"/registry/pods/kube-system/kube-proxy-56l4g\" value_size:3350 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-proxy-56l4g\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-19T16:07:10.374804Z","caller":"traceutil/trace.go:171","msg":"trace[1687414963] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"212.720997ms","start":"2026-01-19T16:07:10.162065Z","end":"2026-01-19T16:07:10.374786Z","steps":["trace[1687414963] 'process raft request'  (duration: 212.665747ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:10.375483Z","caller":"traceutil/trace.go:171","msg":"trace[674778335] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"216.781288ms","start":"2026-01-19T16:07:10.158685Z","end":"2026-01-19T16:07:10.375466Z","steps":["trace[674778335] 'process raft request'  (duration: 78.560701ms)","trace[674778335] 'compare'  (duration: 136.191457ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T16:07:10.375972Z","caller":"traceutil/trace.go:171","msg":"trace[481750762] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:337; }","duration":"217.011969ms","start":"2026-01-19T16:07:10.158945Z","end":"2026-01-19T16:07:10.375957Z","steps":["trace[481750762] 'read index received'  (duration: 78.16345ms)","trace[481750762] 'applied index is now lower than readState.Index'  (duration: 138.846779ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T16:07:10.376088Z","caller":"traceutil/trace.go:171","msg":"trace[1683141078] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"214.142804ms","start":"2026-01-19T16:07:10.161936Z","end":"2026-01-19T16:07:10.376079Z","steps":["trace[1683141078] 'process raft request'  (duration: 212.670326ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:10.376677Z","caller":"traceutil/trace.go:171","msg":"trace[458704765] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"214.684407ms","start":"2026-01-19T16:07:10.161979Z","end":"2026-01-19T16:07:10.376664Z","steps":["trace[458704765] 'process raft request'  (duration: 212.704257ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:10.378011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.0563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-01-19T16:07:10.378057Z","caller":"traceutil/trace.go:171","msg":"trace[599714869] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:333; }","duration":"219.12133ms","start":"2026-01-19T16:07:10.158924Z","end":"2026-01-19T16:07:10.378046Z","steps":["trace[599714869] 'agreement among raft nodes before linearized reading'  (duration: 219.03944ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:10.37875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.901174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3684"}
{"level":"info","ts":"2026-01-19T16:07:10.378856Z","caller":"traceutil/trace.go:171","msg":"trace[299254425] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:333; }","duration":"214.018604ms","start":"2026-01-19T16:07:10.164827Z","end":"2026-01-19T16:07:10.378845Z","steps":["trace[299254425] 'agreement among raft nodes before linearized reading'  (duration: 213.834983ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:13.219249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.309248ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11974398332009305123 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:284 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4187 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-19T16:07:13.219329Z","caller":"traceutil/trace.go:171","msg":"trace[1990598466] linearizableReadLoop","detail":"{readStateIndex:368; appliedIndex:367; }","duration":"266.489161ms","start":"2026-01-19T16:07:12.952824Z","end":"2026-01-19T16:07:13.219313Z","steps":["trace[1990598466] 'read index received'  (duration: 60.986812ms)","trace[1990598466] 'applied index is now lower than readState.Index'  (duration: 205.501379ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T16:07:13.219568Z","caller":"traceutil/trace.go:171","msg":"trace[448024314] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"326.928839ms","start":"2026-01-19T16:07:12.892629Z","end":"2026-01-19T16:07:13.219558Z","steps":["trace[448024314] 'process raft request'  (duration: 121.224239ms)","trace[448024314] 'compare'  (duration: 205.199998ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T16:07:13.219611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:12.89261Z","time spent":"326.978779ms","remote":"127.0.0.1:54484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4245,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:284 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4187 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >"}
{"level":"warn","ts":"2026-01-19T16:07:13.219779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.978473ms","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-01-19T16:07:13.219802Z","caller":"traceutil/trace.go:171","msg":"trace[579367476] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:359; }","duration":"267.033444ms","start":"2026-01-19T16:07:12.952761Z","end":"2026-01-19T16:07:13.219794Z","steps":["trace[579367476] 'agreement among raft nodes before linearized reading'  (duration: 266.984263ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:13.219903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.225839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-01-19T16:07:13.219919Z","caller":"traceutil/trace.go:171","msg":"trace[1189483216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:359; }","duration":"172.27511ms","start":"2026-01-19T16:07:13.047639Z","end":"2026-01-19T16:07:13.219914Z","steps":["trace[1189483216] 'agreement among raft nodes before linearized reading'  (duration: 172.24685ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:13.220062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.878002ms","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-01-19T16:07:13.220079Z","caller":"traceutil/trace.go:171","msg":"trace[528900017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:359; }","duration":"166.945612ms","start":"2026-01-19T16:07:13.053128Z","end":"2026-01-19T16:07:13.220074Z","steps":["trace[528900017] 'agreement among raft nodes before linearized reading'  (duration: 166.915872ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:13.48289Z","caller":"traceutil/trace.go:171","msg":"trace[2003528373] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"254.527649ms","start":"2026-01-19T16:07:13.228282Z","end":"2026-01-19T16:07:13.48281Z","steps":["trace[2003528373] 'process raft request'  (duration: 235.216821ms)","trace[2003528373] 'compare'  (duration: 18.909426ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T16:07:13.483106Z","caller":"traceutil/trace.go:171","msg":"trace[688655263] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"251.088752ms","start":"2026-01-19T16:07:13.231994Z","end":"2026-01-19T16:07:13.483083Z","steps":["trace[688655263] 'process raft request'  (duration: 250.63178ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:13.483223Z","caller":"traceutil/trace.go:171","msg":"trace[186335731] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"252.082797ms","start":"2026-01-19T16:07:13.231128Z","end":"2026-01-19T16:07:13.483211Z","steps":["trace[186335731] 'process raft request'  (duration: 251.453643ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:23.849531Z","caller":"traceutil/trace.go:171","msg":"trace[1775288425] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"469.736262ms","start":"2026-01-19T16:07:23.379777Z","end":"2026-01-19T16:07:23.849513Z","steps":["trace[1775288425] 'process raft request'  (duration: 469.629951ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:23.849647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:23.379767Z","time spent":"469.821052ms","remote":"127.0.0.1:54588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:416 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-01-19T16:07:23.850009Z","caller":"traceutil/trace.go:171","msg":"trace[1512604111] linearizableReadLoop","detail":"{readStateIndex:433; appliedIndex:433; }","duration":"282.779869ms","start":"2026-01-19T16:07:23.56722Z","end":"2026-01-19T16:07:23.85Z","steps":["trace[1512604111] 'read index received'  (duration: 282.776539ms)","trace[1512604111] 'applied index is now lower than readState.Index'  (duration: 2.79µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T16:07:23.850068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.84371ms","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-01-19T16:07:23.850089Z","caller":"traceutil/trace.go:171","msg":"trace[1269712896] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:420; }","duration":"282.88877ms","start":"2026-01-19T16:07:23.567192Z","end":"2026-01-19T16:07:23.850081Z","steps":["trace[1269712896] 'agreement among raft nodes before linearized reading'  (duration: 282.849419ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:23.850978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.658659ms","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-01-19T16:07:23.851002Z","caller":"traceutil/trace.go:171","msg":"trace[595491978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:421; }","duration":"280.692169ms","start":"2026-01-19T16:07:23.570303Z","end":"2026-01-19T16:07:23.850995Z","steps":["trace[595491978] 'agreement among raft nodes before linearized reading'  (duration: 280.607319ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:23.851124Z","caller":"traceutil/trace.go:171","msg":"trace[1463696486] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"169.065321ms","start":"2026-01-19T16:07:23.682052Z","end":"2026-01-19T16:07:23.851117Z","steps":["trace[1463696486] 'process raft request'  (duration: 168.81952ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:29.1896Z","caller":"traceutil/trace.go:171","msg":"trace[2029353134] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"239.048825ms","start":"2026-01-19T16:07:28.950532Z","end":"2026-01-19T16:07:29.189581Z","steps":["trace[2029353134] 'process raft request'  (duration: 238.895264ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:34.31616Z","caller":"traceutil/trace.go:171","msg":"trace[341437675] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:496; }","duration":"106.281949ms","start":"2026-01-19T16:07:34.209859Z","end":"2026-01-19T16:07:34.316141Z","steps":["trace[341437675] 'read index received'  (duration: 106.135809ms)","trace[341437675] 'applied index is now lower than readState.Index'  (duration: 145.34µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T16:07:34.316291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.41725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.154\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-01-19T16:07:34.316321Z","caller":"traceutil/trace.go:171","msg":"trace[1886966905] range","detail":"{range_begin:/registry/masterleases/199.19.213.154; range_end:; response_count:1; response_revision:482; }","duration":"106.502811ms","start":"2026-01-19T16:07:34.209808Z","end":"2026-01-19T16:07:34.316311Z","steps":["trace[1886966905] 'agreement among raft nodes before linearized reading'  (duration: 106.411381ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:34.316573Z","caller":"traceutil/trace.go:171","msg":"trace[1106197160] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"245.040215ms","start":"2026-01-19T16:07:34.071522Z","end":"2026-01-19T16:07:34.316562Z","steps":["trace[1106197160] 'process raft request'  (duration: 244.521252ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:35.041259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.491184ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11974398332009305372 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:262d9bd70271d51b>","response":"size:40"}
{"level":"warn","ts":"2026-01-19T16:07:35.041442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:34.318468Z","time spent":"722.971392ms","remote":"127.0.0.1:48910","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-01-19T16:07:36.662391Z","caller":"traceutil/trace.go:171","msg":"trace[411435296] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:554; }","duration":"132.755574ms","start":"2026-01-19T16:07:36.529616Z","end":"2026-01-19T16:07:36.662371Z","steps":["trace[411435296] 'read index received'  (duration: 132.494842ms)","trace[411435296] 'applied index is now lower than readState.Index'  (duration: 259.952µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T16:07:36.662487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.859774ms","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:12727"}
{"level":"info","ts":"2026-01-19T16:07:36.662508Z","caller":"traceutil/trace.go:171","msg":"trace[604073282] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:539; }","duration":"132.931644ms","start":"2026-01-19T16:07:36.529567Z","end":"2026-01-19T16:07:36.662499Z","steps":["trace[604073282] 'agreement among raft nodes before linearized reading'  (duration: 132.872074ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:36.662705Z","caller":"traceutil/trace.go:171","msg":"trace[2062560713] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"134.638773ms","start":"2026-01-19T16:07:36.528059Z","end":"2026-01-19T16:07:36.662698Z","steps":["trace[2062560713] 'process raft request'  (duration: 134.156041ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:37.649628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.409473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-01-19T16:07:37.64969Z","caller":"traceutil/trace.go:171","msg":"trace[1545773727] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:550; }","duration":"215.507273ms","start":"2026-01-19T16:07:37.434169Z","end":"2026-01-19T16:07:37.649676Z","steps":["trace[1545773727] 'range keys from in-memory index tree'  (duration: 215.336043ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:38.170396Z","caller":"traceutil/trace.go:171","msg":"trace[653204094] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"571.30223ms","start":"2026-01-19T16:07:37.599078Z","end":"2026-01-19T16:07:38.17038Z","steps":["trace[653204094] 'process raft request'  (duration: 571.153619ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:38.170478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:37.599061Z","time spent":"571.37514ms","remote":"127.0.0.1:48930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" value_size:187148 >> failure:<>"}
{"level":"info","ts":"2026-01-19T16:07:38.246395Z","caller":"traceutil/trace.go:171","msg":"trace[1725434324] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:567; }","duration":"528.258761ms","start":"2026-01-19T16:07:37.718119Z","end":"2026-01-19T16:07:38.246378Z","steps":["trace[1725434324] 'read index received'  (duration: 452.781208ms)","trace[1725434324] 'applied index is now lower than readState.Index'  (duration: 75.476543ms)"],"step_count":2}
{"level":"info","ts":"2026-01-19T16:07:38.246627Z","caller":"traceutil/trace.go:171","msg":"trace[45081037] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"588.065375ms","start":"2026-01-19T16:07:37.658555Z","end":"2026-01-19T16:07:38.24662Z","steps":["trace[45081037] 'process raft request'  (duration: 587.692083ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:38.246685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.665818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"}
{"level":"info","ts":"2026-01-19T16:07:38.246735Z","caller":"traceutil/trace.go:171","msg":"trace[381070183] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:552; }","duration":"330.721189ms","start":"2026-01-19T16:07:37.916Z","end":"2026-01-19T16:07:38.246721Z","steps":["trace[381070183] 'agreement among raft nodes before linearized reading'  (duration: 330.640058ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:38.246761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:37.915898Z","time spent":"330.858269ms","remote":"127.0.0.1:48930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4203,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "}
{"level":"warn","ts":"2026-01-19T16:07:38.246895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:37.658538Z","time spent":"588.161156ms","remote":"127.0.0.1:54588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:490 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-19T16:07:38.246982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.482232ms","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-01-19T16:07:38.247Z","caller":"traceutil/trace.go:171","msg":"trace[1051421220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:552; }","duration":"193.522442ms","start":"2026-01-19T16:07:38.053473Z","end":"2026-01-19T16:07:38.246995Z","steps":["trace[1051421220] 'agreement among raft nodes before linearized reading'  (duration: 193.484222ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:38.247082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.119305ms","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-01-19T16:07:38.247098Z","caller":"traceutil/trace.go:171","msg":"trace[1753565404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:552; }","duration":"202.179867ms","start":"2026-01-19T16:07:38.044914Z","end":"2026-01-19T16:07:38.247094Z","steps":["trace[1753565404] 'agreement among raft nodes before linearized reading'  (duration: 202.139766ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:38.24714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.631162ms","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-01-19T16:07:38.247154Z","caller":"traceutil/trace.go:171","msg":"trace[2145463413] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:552; }","duration":"246.683332ms","start":"2026-01-19T16:07:38.000467Z","end":"2026-01-19T16:07:38.247151Z","steps":["trace[2145463413] 'agreement among raft nodes before linearized reading'  (duration: 246.661362ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:38.247191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.972302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T16:07:38.247205Z","caller":"traceutil/trace.go:171","msg":"trace[1280604719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"300.020802ms","start":"2026-01-19T16:07:37.94718Z","end":"2026-01-19T16:07:38.247201Z","steps":["trace[1280604719] 'agreement among raft nodes before linearized reading'  (duration: 300.001112ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:38.247215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:37.947164Z","time spent":"300.048912ms","remote":"127.0.0.1:48888","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-01-19T16:07:38.246906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.785304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"}
{"level":"info","ts":"2026-01-19T16:07:38.247409Z","caller":"traceutil/trace.go:171","msg":"trace[1298359385] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:552; }","duration":"529.308666ms","start":"2026-01-19T16:07:37.718094Z","end":"2026-01-19T16:07:38.247403Z","steps":["trace[1298359385] 'agreement among raft nodes before linearized reading'  (duration: 528.753833ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:38.247426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:37.718082Z","time spent":"529.340466ms","remote":"127.0.0.1:48930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5609,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "}
{"level":"warn","ts":"2026-01-19T16:07:38.246949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.037115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"}
{"level":"info","ts":"2026-01-19T16:07:38.247496Z","caller":"traceutil/trace.go:171","msg":"trace[1943768013] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:552; }","duration":"131.606448ms","start":"2026-01-19T16:07:38.115885Z","end":"2026-01-19T16:07:38.247491Z","steps":["trace[1943768013] 'agreement among raft nodes before linearized reading'  (duration: 131.030355ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:38.692386Z","caller":"traceutil/trace.go:171","msg":"trace[1462769042] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"107.514275ms","start":"2026-01-19T16:07:38.584851Z","end":"2026-01-19T16:07:38.692365Z","steps":["trace[1462769042] 'process raft request'  (duration: 103.914987ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:44.558096Z","caller":"traceutil/trace.go:171","msg":"trace[757923030] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:591; }","duration":"246.984003ms","start":"2026-01-19T16:07:44.311096Z","end":"2026-01-19T16:07:44.55808Z","steps":["trace[757923030] 'read index received'  (duration: 246.855482ms)","trace[757923030] 'applied index is now lower than readState.Index'  (duration: 127.861µs)"],"step_count":2}
{"level":"info","ts":"2026-01-19T16:07:44.558282Z","caller":"traceutil/trace.go:171","msg":"trace[328320247] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"286.693714ms","start":"2026-01-19T16:07:44.271582Z","end":"2026-01-19T16:07:44.558276Z","steps":["trace[328320247] 'process raft request'  (duration: 286.415692ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:44.558485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.378005ms","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-01-19T16:07:44.558516Z","caller":"traceutil/trace.go:171","msg":"trace[542573158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:574; }","duration":"247.418675ms","start":"2026-01-19T16:07:44.311093Z","end":"2026-01-19T16:07:44.558511Z","steps":["trace[542573158] 'agreement among raft nodes before linearized reading'  (duration: 247.313594ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:44.558622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.354509ms","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-01-19T16:07:44.558639Z","caller":"traceutil/trace.go:171","msg":"trace[2113331584] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:574; }","duration":"236.411309ms","start":"2026-01-19T16:07:44.322224Z","end":"2026-01-19T16:07:44.558635Z","steps":["trace[2113331584] 'agreement among raft nodes before linearized reading'  (duration: 236.352918ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:44.558761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.688565ms","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-01-19T16:07:44.558778Z","caller":"traceutil/trace.go:171","msg":"trace[471907068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:574; }","duration":"231.720345ms","start":"2026-01-19T16:07:44.327054Z","end":"2026-01-19T16:07:44.558775Z","steps":["trace[471907068] 'agreement among raft nodes before linearized reading'  (duration: 231.668535ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:45.157515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.046043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-g8wz2\" ","response":"range_response_count:1 size:16656"}
{"level":"warn","ts":"2026-01-19T16:07:45.158138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.348756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T16:07:45.158191Z","caller":"traceutil/trace.go:171","msg":"trace[576850469] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"214.423836ms","start":"2026-01-19T16:07:44.943754Z","end":"2026-01-19T16:07:45.158178Z","steps":["trace[576850469] 'range keys from in-memory index tree'  (duration: 214.287416ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:45.159654Z","caller":"traceutil/trace.go:171","msg":"trace[1690279765] range","detail":"{range_begin:/registry/pods/kube-system/cilium-g8wz2; range_end:; response_count:1; response_revision:581; }","duration":"111.311814ms","start":"2026-01-19T16:07:45.04642Z","end":"2026-01-19T16:07:45.157731Z","steps":["trace[1690279765] 'range keys from in-memory index tree'  (duration: 110.66941ms)"],"step_count":1}
{"level":"info","ts":"2026-01-19T16:07:45.806266Z","caller":"traceutil/trace.go:171","msg":"trace[459885093] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"366.144907ms","start":"2026-01-19T16:07:45.440104Z","end":"2026-01-19T16:07:45.806249Z","steps":["trace[459885093] 'read index received'  (duration: 365.966846ms)","trace[459885093] 'applied index is now lower than readState.Index'  (duration: 177.341µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T16:07:45.80642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.304717ms","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-01-19T16:07:45.806444Z","caller":"traceutil/trace.go:171","msg":"trace[144500383] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:582; }","duration":"366.363068ms","start":"2026-01-19T16:07:45.440074Z","end":"2026-01-19T16:07:45.806437Z","steps":["trace[144500383] 'agreement among raft nodes before linearized reading'  (duration: 366.241987ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:45.806471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:45.44006Z","time spent":"366.401258ms","remote":"127.0.0.1:54588","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-01-19T16:07:45.806777Z","caller":"traceutil/trace.go:171","msg":"trace[2120075139] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"634.899139ms","start":"2026-01-19T16:07:45.171869Z","end":"2026-01-19T16:07:45.806768Z","steps":["trace[2120075139] 'process raft request'  (duration: 634.274536ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:45.806857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:45.171857Z","time spent":"634.937789ms","remote":"127.0.0.1:54484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-g8wz2\" mod_revision:470 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-g8wz2\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-g8wz2\" > >"}
{"level":"warn","ts":"2026-01-19T16:07:47.068408Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11974398332009305596,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-19T16:07:47.568506Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11974398332009305596,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-19T16:07:47.83974Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.28618457s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-19T16:07:47.840018Z","caller":"traceutil/trace.go:171","msg":"trace[865131781] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"1.271832827s","start":"2026-01-19T16:07:46.568165Z","end":"2026-01-19T16:07:47.839998Z","steps":["trace[865131781] 'read index received'  (duration: 1.271690756s)","trace[865131781] 'applied index is now lower than readState.Index'  (duration: 141.521µs)"],"step_count":2}
{"level":"info","ts":"2026-01-19T16:07:47.840066Z","caller":"traceutil/trace.go:171","msg":"trace[1695254260] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.286571471s","start":"2026-01-19T16:07:46.553487Z","end":"2026-01-19T16:07:47.840058Z","steps":["trace[1695254260] 'process raft request'  (duration: 1.28641401s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:47.840137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:46.553471Z","time spent":"1.286611031s","remote":"127.0.0.1:54588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:536 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-01-19T16:07:47.84027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.271283984s","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-01-19T16:07:47.840327Z","caller":"traceutil/trace.go:171","msg":"trace[1030876850] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:584; }","duration":"1.271360424s","start":"2026-01-19T16:07:46.568954Z","end":"2026-01-19T16:07:47.840315Z","steps":["trace[1030876850] 'agreement among raft nodes before linearized reading'  (duration: 1.271240784s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:47.840352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:46.568946Z","time spent":"1.271400575s","remote":"127.0.0.1:54588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-19T16:07:47.840399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.434829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-19T16:07:47.84042Z","caller":"traceutil/trace.go:171","msg":"trace[577615166] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"895.485229ms","start":"2026-01-19T16:07:46.944929Z","end":"2026-01-19T16:07:47.840414Z","steps":["trace[577615166] 'agreement among raft nodes before linearized reading'  (duration: 895.450049ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:47.840434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:46.944914Z","time spent":"895.517349ms","remote":"127.0.0.1:48890","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-01-19T16:07:47.840492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.266015507s","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-01-19T16:07:47.840513Z","caller":"traceutil/trace.go:171","msg":"trace[1950307739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:584; }","duration":"1.266047427s","start":"2026-01-19T16:07:46.574458Z","end":"2026-01-19T16:07:47.840506Z","steps":["trace[1950307739] 'agreement among raft nodes before linearized reading'  (duration: 1.265993827s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:47.840532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:46.574452Z","time spent":"1.266076618s","remote":"127.0.0.1:54588","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-01-19T16:07:47.840634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.266977432s","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-01-19T16:07:47.840651Z","caller":"traceutil/trace.go:171","msg":"trace[336421160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"1.266993562s","start":"2026-01-19T16:07:46.573652Z","end":"2026-01-19T16:07:47.840645Z","steps":["trace[336421160] 'agreement among raft nodes before linearized reading'  (duration: 1.266943882s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:47.840671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:46.573599Z","time spent":"1.267063942s","remote":"127.0.0.1:54588","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-01-19T16:07:47.840515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.272351039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-01-19T16:07:47.840722Z","caller":"traceutil/trace.go:171","msg":"trace[1854602442] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:584; }","duration":"1.27257928s","start":"2026-01-19T16:07:46.568138Z","end":"2026-01-19T16:07:47.840717Z","steps":["trace[1854602442] 'agreement among raft nodes before linearized reading'  (duration: 1.272358639s)"],"step_count":1}
{"level":"warn","ts":"2026-01-19T16:07:47.84074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:46.568114Z","time spent":"1.272621011s","remote":"127.0.0.1:54588","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-01-19T16:09:06.434532Z","caller":"traceutil/trace.go:171","msg":"trace[330606444] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"111.663084ms","start":"2026-01-19T16:09:06.322847Z","end":"2026-01-19T16:09:06.43451Z","steps":["trace[330606444] 'process raft request'  (duration: 53.177059ms)","trace[330606444] 'compare'  (duration: 58.134513ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-19T16:09:34.714422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.694799ms","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-01-19T16:09:34.714473Z","caller":"traceutil/trace.go:171","msg":"trace[634790359] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1031; }","duration":"112.771889ms","start":"2026-01-19T16:09:34.601689Z","end":"2026-01-19T16:09:34.714461Z","steps":["trace[634790359] 'range keys from in-memory index tree'  (duration: 112.566379ms)"],"step_count":1}