{"level":"warn","ts":"2026-03-19T13:32:31.074918Z","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-19T13:32:31.075024Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.42: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.42:2380","--initial-cluster=instance=https://199.19.213.42:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.42:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.42: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-19T13:32:31.07511Z","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-19T13:32:31.075141Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.42:2380"]}
{"level":"info","ts":"2026-03-19T13:32:31.075168Z","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-19T13:32:31.075831Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.42:2379"]}
{"level":"info","ts":"2026-03-19T13:32:31.075904Z","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.19.213.42:2380"],"listen-peer-urls":["https://199.19.213.42:2380"],"advertise-client-urls":["https://199.19.213.42:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.42:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.42: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-19T13:32:31.079774Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.645003ms"}
{"level":"info","ts":"2026-03-19T13:32:31.086695Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"eb9543883cdd7335","cluster-id":"54c72b3f8748f3c1"}
{"level":"info","ts":"2026-03-19T13:32:31.086768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-19T13:32:31.086796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 became follower at term 0"}
{"level":"info","ts":"2026-03-19T13:32:31.086807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft eb9543883cdd7335 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-19T13:32:31.086815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 became follower at term 1"}
{"level":"info","ts":"2026-03-19T13:32:31.086853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 switched to configuration voters=(16975548622858711861)"}
{"level":"warn","ts":"2026-03-19T13:32:31.096536Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-19T13:32:31.098066Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-19T13:32:31.099087Z","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-19T13:32:31.101145Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"eb9543883cdd7335","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-19T13:32:31.101289Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"eb9543883cdd7335","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-19T13:32:31.101924Z","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-19T13:32:31.102032Z","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-19T13:32:31.102047Z","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-19T13:32:31.102773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 switched to configuration voters=(16975548622858711861)"}
{"level":"info","ts":"2026-03-19T13:32:31.102965Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54c72b3f8748f3c1","local-member-id":"eb9543883cdd7335","added-peer-id":"eb9543883cdd7335","added-peer-peer-urls":["https://199.19.213.42:2380"]}
{"level":"info","ts":"2026-03-19T13:32:31.112031Z","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-19T13:32:31.112197Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.42:2380"}
{"level":"info","ts":"2026-03-19T13:32:31.11225Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.42:2380"}
{"level":"info","ts":"2026-03-19T13:32:31.112376Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"eb9543883cdd7335","initial-advertise-peer-urls":["https://199.19.213.42:2380"],"listen-peer-urls":["https://199.19.213.42:2380"],"advertise-client-urls":["https://199.19.213.42:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.42:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-19T13:32:31.112451Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-19T13:32:31.387371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-19T13:32:31.387426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-19T13:32:31.387475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 received MsgPreVoteResp from eb9543883cdd7335 at term 1"}
{"level":"info","ts":"2026-03-19T13:32:31.387491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 became candidate at term 2"}
{"level":"info","ts":"2026-03-19T13:32:31.387497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 received MsgVoteResp from eb9543883cdd7335 at term 2"}
{"level":"info","ts":"2026-03-19T13:32:31.387507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 became leader at term 2"}
{"level":"info","ts":"2026-03-19T13:32:31.387516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: eb9543883cdd7335 elected leader eb9543883cdd7335 at term 2"}
{"level":"info","ts":"2026-03-19T13:32:31.967026Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:32:31.969222Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"eb9543883cdd7335","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.42:2379]}","request-path":"/0/members/eb9543883cdd7335/attributes","cluster-id":"54c72b3f8748f3c1","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-19T13:32:31.969639Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-19T13:32:31.969796Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54c72b3f8748f3c1","local-member-id":"eb9543883cdd7335","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:32:31.970002Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:32:31.970039Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:32:31.970055Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-19T13:32:31.972058Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-19T13:32:31.972086Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-19T13:32:31.974852Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-19T13:32:31.975568Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.42:2379"}
{"level":"info","ts":"2026-03-19T13:33:00.270041Z","caller":"traceutil/trace.go:171","msg":"trace[1254034897] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:484; }","duration":"179.171541ms","start":"2026-03-19T13:33:00.09084Z","end":"2026-03-19T13:33:00.270012Z","steps":["trace[1254034897] 'read index received'  (duration: 179.028653ms)","trace[1254034897] 'applied index is now lower than readState.Index'  (duration: 141.917µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:33:00.270132Z","caller":"traceutil/trace.go:171","msg":"trace[2106711223] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"729.704ms","start":"2026-03-19T13:32:59.540409Z","end":"2026-03-19T13:33:00.270113Z","steps":["trace[2106711223] 'process raft request'  (duration: 729.468128ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:00.270355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.486016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:33:00.270547Z","caller":"traceutil/trace.go:171","msg":"trace[426065566] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:468; }","duration":"179.697507ms","start":"2026-03-19T13:33:00.090806Z","end":"2026-03-19T13:33:00.270504Z","steps":["trace[426065566] 'agreement among raft nodes before linearized reading'  (duration: 179.393912ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:00.270582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:32:59.540391Z","time spent":"729.780593ms","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:464 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-19T13:33:00.411008Z","caller":"traceutil/trace.go:171","msg":"trace[36513557] linearizableReadLoop","detail":"{readStateIndex:486; appliedIndex:485; }","duration":"139.389179ms","start":"2026-03-19T13:33:00.271589Z","end":"2026-03-19T13:33:00.410978Z","steps":["trace[36513557] 'read index received'  (duration: 110.645113ms)","trace[36513557] 'applied index is now lower than readState.Index'  (duration: 28.741826ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:33:00.411152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.542986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:33:00.411228Z","caller":"traceutil/trace.go:171","msg":"trace[2020912725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:468; }","duration":"139.641611ms","start":"2026-03-19T13:33:00.271569Z","end":"2026-03-19T13:33:00.41121Z","steps":["trace[2020912725] 'agreement among raft nodes before linearized reading'  (duration: 139.500514ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:02.619348Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8301714138501345850,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-19T13:33:02.910199Z","caller":"traceutil/trace.go:171","msg":"trace[1549458670] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"798.89773ms","start":"2026-03-19T13:33:02.111267Z","end":"2026-03-19T13:33:02.910164Z","steps":["trace[1549458670] 'process raft request'  (duration: 756.490847ms)","trace[1549458670] 'compare'  (duration: 41.775612ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:33:02.910456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:02.111148Z","time spent":"799.208535ms","remote":"127.0.0.1:56092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317275,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" mod_revision:472 > success:<request_put:<key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" value_size:317207 >> failure:<request_range:<key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" > >"}
{"level":"info","ts":"2026-03-19T13:33:02.910915Z","caller":"traceutil/trace.go:171","msg":"trace[1765061317] linearizableReadLoop","detail":"{readStateIndex:520; appliedIndex:518; }","duration":"791.83246ms","start":"2026-03-19T13:33:02.119058Z","end":"2026-03-19T13:33:02.91089Z","steps":["trace[1765061317] 'read index received'  (duration: 748.691792ms)","trace[1765061317] 'applied index is now lower than readState.Index'  (duration: 43.139888ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:33:02.911032Z","caller":"traceutil/trace.go:171","msg":"trace[1412416111] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"790.738767ms","start":"2026-03-19T13:33:02.120273Z","end":"2026-03-19T13:33:02.911012Z","steps":["trace[1412416111] 'process raft request'  (duration: 790.438842ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:02.911164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:02.120261Z","time spent":"790.825021ms","remote":"127.0.0.1:56436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4339,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/cilium-operator-869df985b8\" mod_revision:497 > success:<request_put:<key:\"/registry/replicasets/kube-system/cilium-operator-869df985b8\" value_size:4271 >> failure:<request_range:<key:\"/registry/replicasets/kube-system/cilium-operator-869df985b8\" > >"}
{"level":"warn","ts":"2026-03-19T13:33:02.911214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.458899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-njvdr\" ","response":"range_response_count:1 size:3637"}
{"level":"info","ts":"2026-03-19T13:33:02.911258Z","caller":"traceutil/trace.go:171","msg":"trace[137281984] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-njvdr; range_end:; response_count:1; response_revision:502; }","duration":"798.555313ms","start":"2026-03-19T13:33:02.112689Z","end":"2026-03-19T13:33:02.911245Z","steps":["trace[137281984] 'agreement among raft nodes before linearized reading'  (duration: 798.337252ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:02.911294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:02.112669Z","time spent":"798.616616ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":3660,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-njvdr\" "}
{"level":"warn","ts":"2026-03-19T13:33:02.911298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.20947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:33:02.911332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.386526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"}
{"level":"info","ts":"2026-03-19T13:33:02.911349Z","caller":"traceutil/trace.go:171","msg":"trace[1537018037] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:502; }","duration":"791.277372ms","start":"2026-03-19T13:33:02.120057Z","end":"2026-03-19T13:33:02.911334Z","steps":["trace[1537018037] 'agreement among raft nodes before linearized reading'  (duration: 791.200519ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:33:02.911382Z","caller":"traceutil/trace.go:171","msg":"trace[594822521] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:502; }","duration":"563.46744ms","start":"2026-03-19T13:33:02.347898Z","end":"2026-03-19T13:33:02.911366Z","steps":["trace[594822521] 'agreement among raft nodes before linearized reading'  (duration: 563.370315ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:02.911419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:02.347886Z","time spent":"563.525053ms","remote":"127.0.0.1:56190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":561,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" "}
{"level":"warn","ts":"2026-03-19T13:33:02.911438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.580083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"}
{"level":"info","ts":"2026-03-19T13:33:02.911467Z","caller":"traceutil/trace.go:171","msg":"trace[1316998675] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:502; }","duration":"564.645286ms","start":"2026-03-19T13:33:02.346813Z","end":"2026-03-19T13:33:02.911458Z","steps":["trace[1316998675] 'agreement among raft nodes before linearized reading'  (duration: 564.591454ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:02.911495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:02.346794Z","time spent":"564.695399ms","remote":"127.0.0.1:56190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":543,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium\" "}
{"level":"warn","ts":"2026-03-19T13:33:02.911385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:02.120048Z","time spent":"791.330055ms","remote":"127.0.0.1:55964","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-19T13:33:02.911575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.722781ms","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-19T13:33:02.911612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.395893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-19T13:33:02.911608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.614277ms","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-19T13:33:02.911622Z","caller":"traceutil/trace.go:171","msg":"trace[804196183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:502; }","duration":"487.806665ms","start":"2026-03-19T13:33:02.423801Z","end":"2026-03-19T13:33:02.911608Z","steps":["trace[804196183] 'agreement among raft nodes before linearized reading'  (duration: 487.724261ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:33:02.91164Z","caller":"traceutil/trace.go:171","msg":"trace[724525720] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:502; }","duration":"636.456216ms","start":"2026-03-19T13:33:02.275175Z","end":"2026-03-19T13:33:02.911632Z","steps":["trace[724525720] 'agreement among raft nodes before linearized reading'  (duration: 636.410173ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:02.911666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:02.275156Z","time spent":"636.503788ms","remote":"127.0.0.1:56254","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-03-19T13:33:02.911669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:02.42378Z","time spent":"487.878009ms","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-19T13:33:02.911674Z","caller":"traceutil/trace.go:171","msg":"trace[1143958811] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:502; }","duration":"487.725851ms","start":"2026-03-19T13:33:02.423924Z","end":"2026-03-19T13:33:02.91165Z","steps":["trace[1143958811] 'agreement among raft nodes before linearized reading'  (duration: 487.619386ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:02.911718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:02.423918Z","time spent":"487.789175ms","remote":"127.0.0.1:56254","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-19T13:33:05.221639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.459179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:33:05.221737Z","caller":"traceutil/trace.go:171","msg":"trace[1351852008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:517; }","duration":"129.608295ms","start":"2026-03-19T13:33:05.092107Z","end":"2026-03-19T13:33:05.221715Z","steps":["trace[1351852008] 'range keys from in-memory index tree'  (duration: 129.360844ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:33:13.415638Z","caller":"traceutil/trace.go:171","msg":"trace[1591438579] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"424.142741ms","start":"2026-03-19T13:33:12.991463Z","end":"2026-03-19T13:33:13.415606Z","steps":["trace[1591438579] 'process raft request'  (duration: 423.971684ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:13.415903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:12.991448Z","time spent":"424.274497ms","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:550 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-19T13:33:13.434178Z","caller":"traceutil/trace.go:171","msg":"trace[1269020872] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:575; }","duration":"441.0348ms","start":"2026-03-19T13:33:12.993124Z","end":"2026-03-19T13:33:13.434159Z","steps":["trace[1269020872] 'read index received'  (duration: 422.397765ms)","trace[1269020872] 'applied index is now lower than readState.Index'  (duration: 18.636275ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:33:13.434372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.224429ms","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-19T13:33:13.434399Z","caller":"traceutil/trace.go:171","msg":"trace[381299405] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:557; }","duration":"441.298202ms","start":"2026-03-19T13:33:12.993091Z","end":"2026-03-19T13:33:13.434389Z","steps":["trace[381299405] 'agreement among raft nodes before linearized reading'  (duration: 441.156836ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:13.434423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:12.99308Z","time spent":"441.336863ms","remote":"127.0.0.1:56254","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-03-19T13:33:13.434379Z","caller":"traceutil/trace.go:171","msg":"trace[1746489700] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"441.874217ms","start":"2026-03-19T13:33:12.992472Z","end":"2026-03-19T13:33:13.434346Z","steps":["trace[1746489700] 'process raft request'  (duration: 441.574514ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:13.434774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:12.992445Z","time spent":"442.274024ms","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:549 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-19T13:33:13.434795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.397557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j6g8b\" ","response":"range_response_count:1 size:16961"}
{"level":"warn","ts":"2026-03-19T13:33:13.434587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.753549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:33:13.434656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.090364ms","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-19T13:33:13.43501Z","caller":"traceutil/trace.go:171","msg":"trace[699693340] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:557; }","duration":"327.191648ms","start":"2026-03-19T13:33:13.107776Z","end":"2026-03-19T13:33:13.434968Z","steps":["trace[699693340] 'agreement among raft nodes before linearized reading'  (duration: 326.717398ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:33:13.435041Z","caller":"traceutil/trace.go:171","msg":"trace[1843026366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:557; }","duration":"410.529493ms","start":"2026-03-19T13:33:13.0245Z","end":"2026-03-19T13:33:13.435029Z","steps":["trace[1843026366] 'agreement among raft nodes before linearized reading'  (duration: 410.013001ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:13.435074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:13.024481Z","time spent":"410.584406ms","remote":"127.0.0.1:56254","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-03-19T13:33:13.435131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:13.107755Z","time spent":"327.310423ms","remote":"127.0.0.1:55964","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-19T13:33:13.435615Z","caller":"traceutil/trace.go:171","msg":"trace[861937839] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j6g8b; range_end:; response_count:1; response_revision:557; }","duration":"436.246164ms","start":"2026-03-19T13:33:12.99935Z","end":"2026-03-19T13:33:13.435596Z","steps":["trace[861937839] 'agreement among raft nodes before linearized reading'  (duration: 435.132966ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:13.435675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:12.999338Z","time spent":"436.324877ms","remote":"127.0.0.1:56176","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-j6g8b\" "}
{"level":"warn","ts":"2026-03-19T13:33:14.681837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.567333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:33:14.681913Z","caller":"traceutil/trace.go:171","msg":"trace[358551237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:560; }","duration":"589.688278ms","start":"2026-03-19T13:33:14.09221Z","end":"2026-03-19T13:33:14.681898Z","steps":["trace[358551237] 'range keys from in-memory index tree'  (duration: 589.454418ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:14.681938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:14.092128Z","time spent":"589.805653ms","remote":"127.0.0.1:55962","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-19T13:33:15.18385Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8301714138501345977,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-19T13:33:15.45353Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.00108777s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-19T13:33:15.453862Z","caller":"traceutil/trace.go:171","msg":"trace[108300224] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"770.80368ms","start":"2026-03-19T13:33:14.683041Z","end":"2026-03-19T13:33:15.453845Z","steps":["trace[108300224] 'read index received'  (duration: 770.603512ms)","trace[108300224] 'applied index is now lower than readState.Index'  (duration: 199.538µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:33:15.453922Z","caller":"traceutil/trace.go:171","msg":"trace[1990658373] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"1.001603171s","start":"2026-03-19T13:33:14.452307Z","end":"2026-03-19T13:33:15.45391Z","steps":["trace[1990658373] 'process raft request'  (duration: 1.001405043s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:15.453971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.912015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:33:15.454003Z","caller":"traceutil/trace.go:171","msg":"trace[197730341] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"770.978358ms","start":"2026-03-19T13:33:14.683016Z","end":"2026-03-19T13:33:15.453994Z","steps":["trace[197730341] 'agreement among raft nodes before linearized reading'  (duration: 770.901804ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:15.454027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:14.683004Z","time spent":"771.01943ms","remote":"127.0.0.1:55964","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-19T13:33:15.454133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:14.452282Z","time spent":"1.001668794s","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:511 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-19T13:33:15.454723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.874373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.42\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-03-19T13:33:15.454804Z","caller":"traceutil/trace.go:171","msg":"trace[190773295] range","detail":"{range_begin:/registry/masterleases/199.19.213.42; range_end:; response_count:1; response_revision:561; }","duration":"517.01293ms","start":"2026-03-19T13:33:14.937771Z","end":"2026-03-19T13:33:15.454784Z","steps":["trace[190773295] 'agreement among raft nodes before linearized reading'  (duration: 516.697206ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:15.454855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:14.937752Z","time spent":"517.094092ms","remote":"127.0.0.1:56012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.42\" "}
{"level":"info","ts":"2026-03-19T13:33:17.26876Z","caller":"traceutil/trace.go:171","msg":"trace[474596663] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"112.108663ms","start":"2026-03-19T13:33:17.156626Z","end":"2026-03-19T13:33:17.268735Z","steps":["trace[474596663] 'process raft request'  (duration: 111.971758ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:18.39131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.245709ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8301714138501346057 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" mod_revision:610 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" value_size:10259 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T13:33:18.39163Z","caller":"traceutil/trace.go:171","msg":"trace[790219500] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"357.43722ms","start":"2026-03-19T13:33:18.034175Z","end":"2026-03-19T13:33:18.391612Z","steps":["trace[790219500] 'process raft request'  (duration: 226.602548ms)","trace[790219500] 'compare'  (duration: 130.03109ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:33:18.391723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:18.034154Z","time spent":"357.537585ms","remote":"127.0.0.1:56038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10362,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" mod_revision:610 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" value_size:10259 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" > >"}
{"level":"info","ts":"2026-03-19T13:33:18.391878Z","caller":"traceutil/trace.go:171","msg":"trace[1238243663] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:632; }","duration":"300.857221ms","start":"2026-03-19T13:33:18.090989Z","end":"2026-03-19T13:33:18.391846Z","steps":["trace[1238243663] 'read index received'  (duration: 169.757997ms)","trace[1238243663] 'applied index is now lower than readState.Index'  (duration: 131.098304ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:33:18.391947Z","caller":"traceutil/trace.go:171","msg":"trace[361287114] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"344.364092ms","start":"2026-03-19T13:33:18.047573Z","end":"2026-03-19T13:33:18.391937Z","steps":["trace[361287114] 'process raft request'  (duration: 343.845391ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:18.391994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:18.047553Z","time spent":"344.416574ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17771,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-j6g8b\" mod_revision:592 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-j6g8b\" value_size:17722 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-j6g8b\" > >"}
{"level":"warn","ts":"2026-03-19T13:33:18.392074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.06765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:33:18.392143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.214916ms","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-19T13:33:18.392162Z","caller":"traceutil/trace.go:171","msg":"trace[1315920097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"301.183525ms","start":"2026-03-19T13:33:18.090955Z","end":"2026-03-19T13:33:18.392138Z","steps":["trace[1315920097] 'agreement among raft nodes before linearized reading'  (duration: 301.048029ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:33:18.392197Z","caller":"traceutil/trace.go:171","msg":"trace[154368055] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:613; }","duration":"236.305559ms","start":"2026-03-19T13:33:18.155874Z","end":"2026-03-19T13:33:18.39218Z","steps":["trace[154368055] 'agreement among raft nodes before linearized reading'  (duration: 236.225686ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:18.392204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:18.090938Z","time spent":"301.258247ms","remote":"127.0.0.1:55962","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-19T13:33:18.683853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.662925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-03-19T13:33:18.683937Z","caller":"traceutil/trace.go:171","msg":"trace[592576281] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:613; }","duration":"128.78737ms","start":"2026-03-19T13:33:18.555126Z","end":"2026-03-19T13:33:18.683914Z","steps":["trace[592576281] 'range keys from in-memory index tree'  (duration: 128.481208ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:25.941347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.017388ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8301714138501346228 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:663 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T13:33:25.94152Z","caller":"traceutil/trace.go:171","msg":"trace[2798757] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"422.737955ms","start":"2026-03-19T13:33:25.518766Z","end":"2026-03-19T13:33:25.941504Z","steps":["trace[2798757] 'process raft request'  (duration: 422.674872ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:25.941577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:25.518762Z","time spent":"422.790176ms","remote":"127.0.0.1:56254","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:661 > 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-03-19T13:33:25.941696Z","caller":"traceutil/trace.go:171","msg":"trace[765195118] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"421.354512ms","start":"2026-03-19T13:33:25.520328Z","end":"2026-03-19T13:33:25.941682Z","steps":["trace[765195118] 'process raft request'  (duration: 421.151095ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:25.941796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:25.52032Z","time spent":"421.413355ms","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:662 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-19T13:33:25.94181Z","caller":"traceutil/trace.go:171","msg":"trace[1956294478] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"423.048176ms","start":"2026-03-19T13:33:25.518718Z","end":"2026-03-19T13:33:25.941766Z","steps":["trace[1956294478] 'process raft request'  (duration: 293.537521ms)","trace[1956294478] 'compare'  (duration: 128.817789ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:33:25.941969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:33:25.51871Z","time spent":"423.182571ms","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:663 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-19T13:33:25.942019Z","caller":"traceutil/trace.go:171","msg":"trace[1915115723] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"242.170087ms","start":"2026-03-19T13:33:25.69984Z","end":"2026-03-19T13:33:25.94201Z","steps":["trace[1915115723] 'process raft request'  (duration: 241.793552ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:33:26.225895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.940565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:33:26.226009Z","caller":"traceutil/trace.go:171","msg":"trace[884900501] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:688; }","duration":"122.121441ms","start":"2026-03-19T13:33:26.103854Z","end":"2026-03-19T13:33:26.225976Z","steps":["trace[884900501] 'range keys from in-memory index tree'  (duration: 121.767108ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:33:28.471226Z","caller":"traceutil/trace.go:171","msg":"trace[1266140780] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"115.729048ms","start":"2026-03-19T13:33:28.35546Z","end":"2026-03-19T13:33:28.471189Z","steps":["trace[1266140780] 'process raft request'  (duration: 114.913629ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:33:28.471532Z","caller":"traceutil/trace.go:171","msg":"trace[251629861] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"115.528911ms","start":"2026-03-19T13:33:28.355744Z","end":"2026-03-19T13:33:28.471273Z","steps":["trace[251629861] 'process raft request'  (duration: 115.297853ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:33:28.482546Z","caller":"traceutil/trace.go:171","msg":"trace[1290807146] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"123.96838ms","start":"2026-03-19T13:33:28.358563Z","end":"2026-03-19T13:33:28.482531Z","steps":["trace[1290807146] 'process raft request'  (duration: 123.904417ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:33:28.691018Z","caller":"traceutil/trace.go:171","msg":"trace[1932073400] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"159.611022ms","start":"2026-03-19T13:33:28.531345Z","end":"2026-03-19T13:33:28.690956Z","steps":["trace[1932073400] 'process raft request'  (duration: 152.614506ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:34:19.454379Z","caller":"traceutil/trace.go:171","msg":"trace[2002318921] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"164.159934ms","start":"2026-03-19T13:34:19.290192Z","end":"2026-03-19T13:34:19.454352Z","steps":["trace[2002318921] 'process raft request'  (duration: 102.268529ms)","trace[2002318921] 'compare'  (duration: 61.764002ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:34:30.518951Z","caller":"traceutil/trace.go:171","msg":"trace[2012260472] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"119.235147ms","start":"2026-03-19T13:34:30.399685Z","end":"2026-03-19T13:34:30.51892Z","steps":["trace[2012260472] 'process raft request'  (duration: 98.035026ms)","trace[2012260472] 'compare'  (duration: 21.069298ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:34:41.793478Z","caller":"traceutil/trace.go:171","msg":"trace[345936725] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"223.620109ms","start":"2026-03-19T13:34:41.569835Z","end":"2026-03-19T13:34:41.793455Z","steps":["trace[345936725] 'process raft request'  (duration: 223.467735ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:34:52.654012Z","caller":"traceutil/trace.go:171","msg":"trace[1168151250] linearizableReadLoop","detail":"{readStateIndex:1072; appliedIndex:1071; }","duration":"150.368958ms","start":"2026-03-19T13:34:52.503616Z","end":"2026-03-19T13:34:52.653985Z","steps":["trace[1168151250] 'read index received'  (duration: 150.161794ms)","trace[1168151250] 'applied index is now lower than readState.Index'  (duration: 206.074µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:34:52.654222Z","caller":"traceutil/trace.go:171","msg":"trace[509790412] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"181.292056ms","start":"2026-03-19T13:34:52.472898Z","end":"2026-03-19T13:34:52.65419Z","steps":["trace[509790412] 'process raft request'  (duration: 180.916779ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:34:52.654256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.609053ms","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-19T13:34:52.654444Z","caller":"traceutil/trace.go:171","msg":"trace[455323649] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1027; }","duration":"150.828767ms","start":"2026-03-19T13:34:52.503565Z","end":"2026-03-19T13:34:52.654394Z","steps":["trace[455323649] 'agreement among raft nodes before linearized reading'  (duration: 150.528671ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:35:15.292974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.712344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:1 size:220"}
{"level":"info","ts":"2026-03-19T13:35:15.293083Z","caller":"traceutil/trace.go:171","msg":"trace[1485086195] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:1; response_revision:1092; }","duration":"100.868316ms","start":"2026-03-19T13:35:15.19219Z","end":"2026-03-19T13:35:15.293058Z","steps":["trace[1485086195] 'range keys from in-memory index tree'  (duration: 100.589552ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:35:20.388748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.144788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j6g8b\" ","response":"range_response_count:1 size:18521"}
{"level":"info","ts":"2026-03-19T13:35:20.388815Z","caller":"traceutil/trace.go:171","msg":"trace[2116392751] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j6g8b; range_end:; response_count:1; response_revision:1105; }","duration":"121.265361ms","start":"2026-03-19T13:35:20.267534Z","end":"2026-03-19T13:35:20.3888Z","steps":["trace[2116392751] 'range keys from in-memory index tree'  (duration: 120.960216ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:35:22.391646Z","caller":"traceutil/trace.go:171","msg":"trace[946496231] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"138.451494ms","start":"2026-03-19T13:35:22.25317Z","end":"2026-03-19T13:35:22.391622Z","steps":["trace[946496231] 'process raft request'  (duration: 83.294026ms)","trace[946496231] 'compare'  (duration: 54.751751ms)"],"step_count":2}