{"level":"warn","ts":"2026-05-12T05:40:33.15937Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-12T05:40:33.159461Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-05-12T05:40:33.159539Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-12T05:40:33.159548Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]}
{"level":"info","ts":"2026-05-12T05:40:33.159588Z","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-05-12T05:40:33.160266Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]}
{"level":"info","ts":"2026-05-12T05:40:33.160342Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-05-12T05:40:33.16592Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.257607ms"}
{"level":"info","ts":"2026-05-12T05:40:33.174029Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"}
{"level":"info","ts":"2026-05-12T05:40:33.174109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"}
{"level":"info","ts":"2026-05-12T05:40:33.174136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"}
{"level":"info","ts":"2026-05-12T05:40:33.174148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-12T05:40:33.174163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"}
{"level":"info","ts":"2026-05-12T05:40:33.174213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"}
{"level":"warn","ts":"2026-05-12T05:40:33.182868Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-12T05:40:33.184848Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-12T05:40:33.18661Z","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-05-12T05:40:33.214751Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-12T05:40:33.219722Z","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-05-12T05:40:33.219834Z","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-05-12T05:40:33.219869Z","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-05-12T05:40:33.219635Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-12T05:40:33.22054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"}
{"level":"info","ts":"2026-05-12T05:40:33.221477Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]}
{"level":"info","ts":"2026-05-12T05:40:33.223829Z","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-05-12T05:40:33.223945Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"}
{"level":"info","ts":"2026-05-12T05:40:33.223972Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"}
{"level":"info","ts":"2026-05-12T05:40:33.224388Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-12T05:40:33.224439Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-12T05:40:34.175346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"}
{"level":"info","ts":"2026-05-12T05:40:34.175414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-12T05:40:34.175459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"}
{"level":"info","ts":"2026-05-12T05:40:34.17548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"}
{"level":"info","ts":"2026-05-12T05:40:34.175496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"}
{"level":"info","ts":"2026-05-12T05:40:34.175513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"}
{"level":"info","ts":"2026-05-12T05:40:34.175527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"}
{"level":"info","ts":"2026-05-12T05:40:34.179329Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-12T05:40:34.180642Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-12T05:40:34.18085Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-12T05:40:34.180824Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-12T05:40:34.181269Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-12T05:40:34.181339Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-12T05:40:34.184043Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"}
{"level":"info","ts":"2026-05-12T05:40:34.184831Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-12T05:40:34.232972Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-12T05:40:34.233276Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-12T05:40:34.233483Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-05-12T05:40:38.24782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.341826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:root-ca-cert-publisher\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:40:38.247974Z","caller":"traceutil/trace.go:171","msg":"trace[2033254233] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:root-ca-cert-publisher; range_end:; response_count:0; response_revision:178; }","duration":"130.553161ms","start":"2026-05-12T05:40:38.117393Z","end":"2026-05-12T05:40:38.247946Z","steps":["trace[2033254233] 'range keys from in-memory index tree'  (duration: 130.270015ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:38.248047Z","caller":"traceutil/trace.go:171","msg":"trace[1503474479] linearizableReadLoop","detail":"{readStateIndex:183; appliedIndex:182; }","duration":"109.700561ms","start":"2026-05-12T05:40:38.138301Z","end":"2026-05-12T05:40:38.248001Z","steps":["trace[1503474479] 'read index received'  (duration: 104.869524ms)","trace[1503474479] 'applied index is now lower than readState.Index'  (duration: 4.829187ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:40:38.248253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.938147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:40:38.248374Z","caller":"traceutil/trace.go:171","msg":"trace[818131276] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:178; }","duration":"110.140851ms","start":"2026-05-12T05:40:38.138204Z","end":"2026-05-12T05:40:38.248345Z","steps":["trace[818131276] 'agreement among raft nodes before linearized reading'  (duration: 109.919906ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:38.361954Z","caller":"traceutil/trace.go:171","msg":"trace[786983149] transaction","detail":"{read_only:false; response_revision:180; number_of_response:1; }","duration":"109.786572ms","start":"2026-05-12T05:40:38.252125Z","end":"2026-05-12T05:40:38.361912Z","steps":["trace[786983149] 'process raft request'  (duration: 95.955567ms)","trace[786983149] 'compare'  (duration: 13.484628ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:40:38.361964Z","caller":"traceutil/trace.go:171","msg":"trace[2129964608] transaction","detail":"{read_only:false; response_revision:181; number_of_response:1; }","duration":"109.363874ms","start":"2026-05-12T05:40:38.252567Z","end":"2026-05-12T05:40:38.361931Z","steps":["trace[2129964608] 'process raft request'  (duration: 109.226581ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:38.805215Z","caller":"traceutil/trace.go:171","msg":"trace[2085391038] linearizableReadLoop","detail":"{readStateIndex:211; appliedIndex:210; }","duration":"107.003411ms","start":"2026-05-12T05:40:38.69818Z","end":"2026-05-12T05:40:38.805184Z","steps":["trace[2085391038] 'read index received'  (duration: 32.520857ms)","trace[2085391038] 'applied index is now lower than readState.Index'  (duration: 74.481304ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:40:38.805254Z","caller":"traceutil/trace.go:171","msg":"trace[1457400268] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"107.595405ms","start":"2026-05-12T05:40:38.697615Z","end":"2026-05-12T05:40:38.80521Z","steps":["trace[1457400268] 'process raft request'  (duration: 33.159431ms)","trace[1457400268] 'compare'  (duration: 74.24845ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:40:38.805658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.245187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:40:38.805713Z","caller":"traceutil/trace.go:171","msg":"trace[1213919396] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::leader-locking-kube-scheduler; range_end:; response_count:0; response_revision:206; }","duration":"107.572854ms","start":"2026-05-12T05:40:38.698123Z","end":"2026-05-12T05:40:38.805696Z","steps":["trace[1213919396] 'agreement among raft nodes before linearized reading'  (duration: 107.224927ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:39.248138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.523538ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646843345310652428 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/instance.18aebaed8b911767\" mod_revision:210 > success:<request_put:<key:\"/registry/events/default/instance.18aebaed8b911767\" value_size:574 lease:5646843345310652343 >> failure:<request_range:<key:\"/registry/events/default/instance.18aebaed8b911767\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-12T05:40:39.248272Z","caller":"traceutil/trace.go:171","msg":"trace[1137417286] linearizableReadLoop","detail":"{readStateIndex:221; appliedIndex:220; }","duration":"358.508788ms","start":"2026-05-12T05:40:38.889747Z","end":"2026-05-12T05:40:39.248256Z","steps":["trace[1137417286] 'read index received'  (duration: 52.193333ms)","trace[1137417286] 'applied index is now lower than readState.Index'  (duration: 306.314015ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:40:39.248368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.63667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:40:39.248404Z","caller":"traceutil/trace.go:171","msg":"trace[2133841589] range","detail":"{range_begin:/registry/rolebindings/kube-public/system:controller:bootstrap-signer; range_end:; response_count:0; response_revision:216; }","duration":"358.736053ms","start":"2026-05-12T05:40:38.889658Z","end":"2026-05-12T05:40:39.248394Z","steps":["trace[2133841589] 'agreement among raft nodes before linearized reading'  (duration: 358.642551ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:39.248441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:38.889627Z","time spent":"358.806264ms","remote":"127.0.0.1:50350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":27,"request content":"key:\"/registry/rolebindings/kube-public/system:controller:bootstrap-signer\" "}
{"level":"info","ts":"2026-05-12T05:40:39.248482Z","caller":"traceutil/trace.go:171","msg":"trace[180849964] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"389.739046ms","start":"2026-05-12T05:40:38.858635Z","end":"2026-05-12T05:40:39.248374Z","steps":["trace[180849964] 'process raft request'  (duration: 83.290198ms)","trace[180849964] 'compare'  (duration: 305.367605ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:40:39.248845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:38.858615Z","time spent":"390.067414ms","remote":"127.0.0.1:50080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.18aebaed8b911767\" mod_revision:210 > success:<request_put:<key:\"/registry/events/default/instance.18aebaed8b911767\" value_size:574 lease:5646843345310652343 >> failure:<request_range:<key:\"/registry/events/default/instance.18aebaed8b911767\" > >"}
{"level":"warn","ts":"2026-05-12T05:40:39.71437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.409896ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646843345310652429 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3917 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-12T05:40:39.714586Z","caller":"traceutil/trace.go:171","msg":"trace[2139152313] linearizableReadLoop","detail":"{readStateIndex:223; appliedIndex:221; }","duration":"462.943249ms","start":"2026-05-12T05:40:39.251625Z","end":"2026-05-12T05:40:39.714569Z","steps":["trace[2139152313] 'read index received'  (duration: 220.199786ms)","trace[2139152313] 'applied index is now lower than readState.Index'  (duration: 242.740353ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:40:39.7147Z","caller":"traceutil/trace.go:171","msg":"trace[1626591012] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"803.264744ms","start":"2026-05-12T05:40:38.911424Z","end":"2026-05-12T05:40:39.714689Z","steps":["trace[1626591012] 'process raft request'  (duration: 560.434039ms)","trace[1626591012] 'compare'  (duration: 242.273903ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:40:39.714763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:38.911399Z","time spent":"803.338296ms","remote":"127.0.0.1:50172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3917 >> failure:<>"}
{"level":"info","ts":"2026-05-12T05:40:39.714979Z","caller":"traceutil/trace.go:171","msg":"trace[607208194] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"795.102584ms","start":"2026-05-12T05:40:38.919866Z","end":"2026-05-12T05:40:39.714969Z","steps":["trace[607208194] 'process raft request'  (duration: 794.651254ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:39.715034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:38.919852Z","time spent":"795.158355ms","remote":"127.0.0.1:50172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:5824 >> failure:<>"}
{"level":"warn","ts":"2026-05-12T05:40:39.715218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.457353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:40:39.715308Z","caller":"traceutil/trace.go:171","msg":"trace[330902403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:218; }","duration":"133.603806ms","start":"2026-05-12T05:40:39.581683Z","end":"2026-05-12T05:40:39.715286Z","steps":["trace[330902403] 'agreement among raft nodes before linearized reading'  (duration: 133.470563ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:39.715282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.619274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-public\" ","response":"range_response_count:1 size:351"}
{"level":"warn","ts":"2026-05-12T05:40:39.715284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.840815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18aebaed8b915bff\" ","response":"range_response_count:1 size:653"}
{"level":"info","ts":"2026-05-12T05:40:39.715404Z","caller":"traceutil/trace.go:171","msg":"trace[1514405750] range","detail":"{range_begin:/registry/namespaces/kube-public; range_end:; response_count:1; response_revision:218; }","duration":"463.806597ms","start":"2026-05-12T05:40:39.251572Z","end":"2026-05-12T05:40:39.715379Z","steps":["trace[1514405750] 'agreement among raft nodes before linearized reading'  (duration: 463.506001ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:39.715466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:39.251548Z","time spent":"463.90387ms","remote":"127.0.0.1:50104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-public\" "}
{"level":"info","ts":"2026-05-12T05:40:39.71545Z","caller":"traceutil/trace.go:171","msg":"trace[1213885857] range","detail":"{range_begin:/registry/events/default/instance.18aebaed8b915bff; range_end:; response_count:1; response_revision:218; }","duration":"463.04199ms","start":"2026-05-12T05:40:39.252363Z","end":"2026-05-12T05:40:39.715405Z","steps":["trace[1213885857] 'agreement among raft nodes before linearized reading'  (duration: 462.793514ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:39.715849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:39.252326Z","time spent":"463.50662ms","remote":"127.0.0.1:50080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":675,"request content":"key:\"/registry/events/default/instance.18aebaed8b915bff\" "}
{"level":"warn","ts":"2026-05-12T05:40:45.390973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.010838269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:40:45.391101Z","caller":"traceutil/trace.go:171","msg":"trace[116568407] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:0; response_revision:338; }","duration":"1.011033173s","start":"2026-05-12T05:40:44.380036Z","end":"2026-05-12T05:40:45.391069Z","steps":["trace[116568407] 'range keys from in-memory index tree'  (duration: 1.010728487s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:45.391153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:44.38001Z","time spent":"1.011130865s","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" "}
{"level":"warn","ts":"2026-05-12T05:40:45.391403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.584986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-12T05:40:45.391445Z","caller":"traceutil/trace.go:171","msg":"trace[769101036] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:338; }","duration":"961.661778ms","start":"2026-05-12T05:40:44.429772Z","end":"2026-05-12T05:40:45.391434Z","steps":["trace[769101036] 'range keys from in-memory index tree'  (duration: 961.489965ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:45.391478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:44.429752Z","time spent":"961.71588ms","remote":"127.0.0.1:50278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-12T05:40:45.392005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.345569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"}
{"level":"info","ts":"2026-05-12T05:40:45.392077Z","caller":"traceutil/trace.go:171","msg":"trace[350016785] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:338; }","duration":"533.468662ms","start":"2026-05-12T05:40:44.858592Z","end":"2026-05-12T05:40:45.392061Z","steps":["trace[350016785] 'range keys from in-memory index tree'  (duration: 533.236777ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:45.392124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:44.858568Z","time spent":"533.542454ms","remote":"127.0.0.1:50172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4348,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "}
{"level":"info","ts":"2026-05-12T05:40:45.866333Z","caller":"traceutil/trace.go:171","msg":"trace[1963617870] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"468.331311ms","start":"2026-05-12T05:40:45.397921Z","end":"2026-05-12T05:40:45.866252Z","steps":["trace[1963617870] 'process raft request'  (duration: 468.047445ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:45.866608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:45.397875Z","time spent":"468.579756ms","remote":"127.0.0.1:50278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:319 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-12T05:40:46.500759Z","caller":"traceutil/trace.go:171","msg":"trace[1521151071] linearizableReadLoop","detail":"{readStateIndex:356; appliedIndex:353; }","duration":"830.128924ms","start":"2026-05-12T05:40:45.670597Z","end":"2026-05-12T05:40:46.500726Z","steps":["trace[1521151071] 'read index received'  (duration: 195.40407ms)","trace[1521151071] 'applied index is now lower than readState.Index'  (duration: 634.723494ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:40:46.501045Z","caller":"traceutil/trace.go:171","msg":"trace[367279782] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"1.100340206s","start":"2026-05-12T05:40:45.400491Z","end":"2026-05-12T05:40:46.500831Z","steps":["trace[367279782] 'process raft request'  (duration: 1.099945498s)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:46.501081Z","caller":"traceutil/trace.go:171","msg":"trace[1978625793] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"1.097377051s","start":"2026-05-12T05:40:45.403634Z","end":"2026-05-12T05:40:46.501011Z","steps":["trace[1978625793] 'process raft request'  (duration: 1.097020403s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:46.50131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.679956ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-12T05:40:46.501966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:45.403607Z","time spent":"1.09824909s","remote":"127.0.0.1:50172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:326 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4253 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >"}
{"level":"info","ts":"2026-05-12T05:40:46.501986Z","caller":"traceutil/trace.go:171","msg":"trace[1237718887] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:341; }","duration":"831.373712ms","start":"2026-05-12T05:40:45.670587Z","end":"2026-05-12T05:40:46.501961Z","steps":["trace[1237718887] 'agreement among raft nodes before linearized reading'  (duration: 830.639695ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:46.501956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:45.400481Z","time spent":"1.101336539s","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":205,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" value_size:132 >> failure:<>"}
{"level":"warn","ts":"2026-05-12T05:40:47.000926Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843345310652700,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-12T05:40:47.148903Z","caller":"traceutil/trace.go:171","msg":"trace[132639235] linearizableReadLoop","detail":"{readStateIndex:357; appliedIndex:356; }","duration":"647.92838ms","start":"2026-05-12T05:40:46.500861Z","end":"2026-05-12T05:40:47.148789Z","steps":["trace[132639235] 'read index received'  (duration: 643.127465ms)","trace[132639235] 'applied index is now lower than readState.Index'  (duration: 4.798935ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:40:47.149262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183246204s","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-05-12T05:40:47.148913Z","caller":"traceutil/trace.go:171","msg":"trace[1715584600] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"1.071372839s","start":"2026-05-12T05:40:46.077498Z","end":"2026-05-12T05:40:47.148871Z","steps":["trace[1715584600] 'process raft request'  (duration: 1.066586714s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.149475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.186087816s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-05-12T05:40:47.149515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.194217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"}
{"level":"info","ts":"2026-05-12T05:40:47.149535Z","caller":"traceutil/trace.go:171","msg":"trace[346293661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:342; }","duration":"1.18623827s","start":"2026-05-12T05:40:45.963281Z","end":"2026-05-12T05:40:47.14952Z","steps":["trace[346293661] 'agreement among raft nodes before linearized reading'  (duration: 1.186110307s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.149587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:45.963245Z","time spent":"1.186329402s","remote":"127.0.0.1:50278","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-05-12T05:40:47.149554Z","caller":"traceutil/trace.go:171","msg":"trace[976267762] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:342; }","duration":"643.310669ms","start":"2026-05-12T05:40:46.506233Z","end":"2026-05-12T05:40:47.149544Z","steps":["trace[976267762] 'agreement among raft nodes before linearized reading'  (duration: 643.163736ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.149641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.077454Z","time spent":"1.072004023s","remote":"127.0.0.1:50278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:66 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-05-12T05:40:47.149726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.107334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"}
{"level":"warn","ts":"2026-05-12T05:40:47.149742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.375435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-05-12T05:40:47.149763Z","caller":"traceutil/trace.go:171","msg":"trace[688347710] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:342; }","duration":"359.178096ms","start":"2026-05-12T05:40:46.790576Z","end":"2026-05-12T05:40:47.149754Z","steps":["trace[688347710] 'agreement among raft nodes before linearized reading'  (duration: 359.062123ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:47.149805Z","caller":"traceutil/trace.go:171","msg":"trace[1026062735] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:342; }","duration":"563.565229ms","start":"2026-05-12T05:40:46.58622Z","end":"2026-05-12T05:40:47.149785Z","steps":["trace[1026062735] 'agreement among raft nodes before linearized reading'  (duration: 563.449287ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.149811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.790559Z","time spent":"359.241897ms","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "}
{"level":"warn","ts":"2026-05-12T05:40:47.149791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.506212Z","time spent":"643.533695ms","remote":"127.0.0.1:50172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5358,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "}
{"level":"warn","ts":"2026-05-12T05:40:47.149853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.586202Z","time spent":"563.641591ms","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "}
{"level":"info","ts":"2026-05-12T05:40:47.149317Z","caller":"traceutil/trace.go:171","msg":"trace[139016208] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:342; }","duration":"1.183374026s","start":"2026-05-12T05:40:45.965928Z","end":"2026-05-12T05:40:47.149302Z","steps":["trace[139016208] 'agreement among raft nodes before linearized reading'  (duration: 1.183118521s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.149941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:45.965905Z","time spent":"1.184022351s","remote":"127.0.0.1:50278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-12T05:40:47.150021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.046753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"}
{"level":"warn","ts":"2026-05-12T05:40:47.150053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.23278596s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-12T05:40:47.150053Z","caller":"traceutil/trace.go:171","msg":"trace[624784937] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:342; }","duration":"566.105025ms","start":"2026-05-12T05:40:46.583937Z","end":"2026-05-12T05:40:47.150042Z","steps":["trace[624784937] 'agreement among raft nodes before linearized reading'  (duration: 566.045914ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:47.150082Z","caller":"traceutil/trace.go:171","msg":"trace[1489383767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:342; }","duration":"1.232846422s","start":"2026-05-12T05:40:45.917225Z","end":"2026-05-12T05:40:47.150071Z","steps":["trace[1489383767] 'agreement among raft nodes before linearized reading'  (duration: 1.232794881s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.150089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.583925Z","time spent":"566.157526ms","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "}
{"level":"warn","ts":"2026-05-12T05:40:47.15011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:45.917205Z","time spent":"1.232898063s","remote":"127.0.0.1:50278","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-05-12T05:40:47.150116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.712674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-05-12T05:40:47.150146Z","caller":"traceutil/trace.go:171","msg":"trace[220809447] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:342; }","duration":"388.771995ms","start":"2026-05-12T05:40:46.761364Z","end":"2026-05-12T05:40:47.150136Z","steps":["trace[220809447] 'agreement among raft nodes before linearized reading'  (duration: 388.710014ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.150179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.761352Z","time spent":"388.819697ms","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "}
{"level":"warn","ts":"2026-05-12T05:40:47.150325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.803831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"}
{"level":"info","ts":"2026-05-12T05:40:47.150352Z","caller":"traceutil/trace.go:171","msg":"trace[9143582] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:342; }","duration":"406.881532ms","start":"2026-05-12T05:40:46.743461Z","end":"2026-05-12T05:40:47.150342Z","steps":["trace[9143582] 'agreement among raft nodes before linearized reading'  (duration: 406.793151ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.150361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.750515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"}
{"level":"warn","ts":"2026-05-12T05:40:47.150389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.74343Z","time spent":"406.943663ms","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "}
{"level":"info","ts":"2026-05-12T05:40:47.15042Z","caller":"traceutil/trace.go:171","msg":"trace[1926477170] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:342; }","duration":"610.856377ms","start":"2026-05-12T05:40:46.539546Z","end":"2026-05-12T05:40:47.150402Z","steps":["trace[1926477170] 'agreement among raft nodes before linearized reading'  (duration: 610.692043ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.150464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.539519Z","time spent":"610.937098ms","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "}
{"level":"warn","ts":"2026-05-12T05:40:47.150465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.207168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"}
{"level":"warn","ts":"2026-05-12T05:40:47.150464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.144669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"}
{"level":"warn","ts":"2026-05-12T05:40:47.150506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.073507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"}
{"level":"info","ts":"2026-05-12T05:40:47.150505Z","caller":"traceutil/trace.go:171","msg":"trace[319759563] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:342; }","duration":"613.315521ms","start":"2026-05-12T05:40:46.537179Z","end":"2026-05-12T05:40:47.150494Z","steps":["trace[319759563] 'agreement among raft nodes before linearized reading'  (duration: 613.207228ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:47.150554Z","caller":"traceutil/trace.go:171","msg":"trace[197941734] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:342; }","duration":"562.137749ms","start":"2026-05-12T05:40:46.588404Z","end":"2026-05-12T05:40:47.150542Z","steps":["trace[197941734] 'agreement among raft nodes before linearized reading'  (duration: 562.059367ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:47.150532Z","caller":"traceutil/trace.go:171","msg":"trace[1832002727] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:342; }","duration":"578.239801ms","start":"2026-05-12T05:40:46.572268Z","end":"2026-05-12T05:40:47.150507Z","steps":["trace[1832002727] 'agreement among raft nodes before linearized reading'  (duration: 578.081388ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.150584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.588392Z","time spent":"562.1856ms","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "}
{"level":"warn","ts":"2026-05-12T05:40:47.150602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.549676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"}
{"level":"warn","ts":"2026-05-12T05:40:47.150601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.572251Z","time spent":"578.337713ms","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "}
{"level":"info","ts":"2026-05-12T05:40:47.150642Z","caller":"traceutil/trace.go:171","msg":"trace[1242197944] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:342; }","duration":"603.606328ms","start":"2026-05-12T05:40:46.547025Z","end":"2026-05-12T05:40:47.150631Z","steps":["trace[1242197944] 'agreement among raft nodes before linearized reading'  (duration: 603.529506ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.150681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.547013Z","time spent":"603.660539ms","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "}
{"level":"warn","ts":"2026-05-12T05:40:47.150706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.06327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"}
{"level":"warn","ts":"2026-05-12T05:40:47.150582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.537161Z","time spent":"613.411772ms","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "}
{"level":"info","ts":"2026-05-12T05:40:47.150754Z","caller":"traceutil/trace.go:171","msg":"trace[17250614] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:342; }","duration":"414.139942ms","start":"2026-05-12T05:40:46.736592Z","end":"2026-05-12T05:40:47.150732Z","steps":["trace[17250614] 'agreement among raft nodes before linearized reading'  (duration: 414.0665ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.151025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:46.736571Z","time spent":"414.417447ms","remote":"127.0.0.1:50202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "}
{"level":"warn","ts":"2026-05-12T05:40:47.365895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.183145ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646843345310652726 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-proxy-2d56f\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-proxy-2d56f\" value_size:3327 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-12T05:40:47.366362Z","caller":"traceutil/trace.go:171","msg":"trace[1079887497] linearizableReadLoop","detail":"{readStateIndex:376; appliedIndex:375; }","duration":"135.100292ms","start":"2026-05-12T05:40:47.231216Z","end":"2026-05-12T05:40:47.366317Z","steps":["trace[1079887497] 'read index received'  (duration: 20.136342ms)","trace[1079887497] 'applied index is now lower than readState.Index'  (duration: 114.96027ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:40:47.366375Z","caller":"traceutil/trace.go:171","msg":"trace[1962935905] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"142.940344ms","start":"2026-05-12T05:40:47.223286Z","end":"2026-05-12T05:40:47.366227Z","steps":["trace[1962935905] 'process raft request'  (duration: 27.34478ms)","trace[1962935905] 'compare'  (duration: 114.994941ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:40:47.366672Z","caller":"traceutil/trace.go:171","msg":"trace[1437670034] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"134.064709ms","start":"2026-05-12T05:40:47.232594Z","end":"2026-05-12T05:40:47.366658Z","steps":["trace[1437670034] 'process raft request'  (duration: 133.63387ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:47.366687Z","caller":"traceutil/trace.go:171","msg":"trace[1412600380] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"134.001378ms","start":"2026-05-12T05:40:47.232667Z","end":"2026-05-12T05:40:47.366668Z","steps":["trace[1412600380] 'process raft request'  (duration: 133.683501ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:47.366784Z","caller":"traceutil/trace.go:171","msg":"trace[162836609] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"128.179841ms","start":"2026-05-12T05:40:47.238532Z","end":"2026-05-12T05:40:47.366712Z","steps":["trace[162836609] 'process raft request'  (duration: 128.012917ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:47.366891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.626293ms","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-05-12T05:40:47.366987Z","caller":"traceutil/trace.go:171","msg":"trace[1484840344] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:366; }","duration":"135.807287ms","start":"2026-05-12T05:40:47.231165Z","end":"2026-05-12T05:40:47.366972Z","steps":["trace[1484840344] 'agreement among raft nodes before linearized reading'  (duration: 135.512251ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:47.367003Z","caller":"traceutil/trace.go:171","msg":"trace[1138625847] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"128.224551ms","start":"2026-05-12T05:40:47.238766Z","end":"2026-05-12T05:40:47.366991Z","steps":["trace[1138625847] 'process raft request'  (duration: 127.863983ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:47.367061Z","caller":"traceutil/trace.go:171","msg":"trace[878617255] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"124.278594ms","start":"2026-05-12T05:40:47.242715Z","end":"2026-05-12T05:40:47.366994Z","steps":["trace[878617255] 'process raft request'  (duration: 124.085009ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:47.366728Z","caller":"traceutil/trace.go:171","msg":"trace[1832773793] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"133.880986ms","start":"2026-05-12T05:40:47.232789Z","end":"2026-05-12T05:40:47.36667Z","steps":["trace[1832773793] 'process raft request'  (duration: 133.61465ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:47.367358Z","caller":"traceutil/trace.go:171","msg":"trace[534376248] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"124.810225ms","start":"2026-05-12T05:40:47.242534Z","end":"2026-05-12T05:40:47.367344Z","steps":["trace[534376248] 'process raft request'  (duration: 124.148891ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:48.453163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.181283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-12T05:40:48.453258Z","caller":"traceutil/trace.go:171","msg":"trace[539777119] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:390; }","duration":"581.332017ms","start":"2026-05-12T05:40:47.871905Z","end":"2026-05-12T05:40:48.453237Z","steps":["trace[539777119] 'range keys from in-memory index tree'  (duration: 581.03683ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:48.453318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:47.871876Z","time spent":"581.432098ms","remote":"127.0.0.1:50278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-12T05:40:48.569485Z","caller":"traceutil/trace.go:171","msg":"trace[701720591] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"110.093462ms","start":"2026-05-12T05:40:48.459369Z","end":"2026-05-12T05:40:48.569463Z","steps":["trace[701720591] 'process raft request'  (duration: 109.947739ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:59.821203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.998384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:40:59.821328Z","caller":"traceutil/trace.go:171","msg":"trace[100258810] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:458; }","duration":"352.18621ms","start":"2026-05-12T05:40:59.469114Z","end":"2026-05-12T05:40:59.821301Z","steps":["trace[100258810] 'range keys from in-memory index tree'  (duration: 351.852679ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:59.821368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:40:59.469089Z","time spent":"352.270312ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-12T05:41:12.043696Z","caller":"traceutil/trace.go:171","msg":"trace[729786228] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"161.001495ms","start":"2026-05-12T05:41:11.882654Z","end":"2026-05-12T05:41:12.043655Z","steps":["trace[729786228] 'process raft request'  (duration: 155.163384ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:41:12.044591Z","caller":"traceutil/trace.go:171","msg":"trace[816916344] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"161.53831ms","start":"2026-05-12T05:41:11.883019Z","end":"2026-05-12T05:41:12.044557Z","steps":["trace[816916344] 'process raft request'  (duration: 160.84432ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:12.972096Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843345310653071,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-12T05:41:13.275626Z","caller":"traceutil/trace.go:171","msg":"trace[1022559084] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"911.756354ms","start":"2026-05-12T05:41:12.363838Z","end":"2026-05-12T05:41:13.275594Z","steps":["trace[1022559084] 'process raft request'  (duration: 910.350663ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:13.275892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:12.363811Z","time spent":"911.919238ms","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" mod_revision:571 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" value_size:80585 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" > >"}
{"level":"info","ts":"2026-05-12T05:41:13.282283Z","caller":"traceutil/trace.go:171","msg":"trace[290787513] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:598; }","duration":"811.039952ms","start":"2026-05-12T05:41:12.471201Z","end":"2026-05-12T05:41:13.282241Z","steps":["trace[290787513] 'read index received'  (duration: 803.105429ms)","trace[290787513] 'applied index is now lower than readState.Index'  (duration: 7.933613ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:41:13.282789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.541096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:41:13.282957Z","caller":"traceutil/trace.go:171","msg":"trace[1953090073] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"905.624092ms","start":"2026-05-12T05:41:12.377323Z","end":"2026-05-12T05:41:13.282947Z","steps":["trace[1953090073] 'process raft request'  (duration: 904.558121ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:41:13.282958Z","caller":"traceutil/trace.go:171","msg":"trace[176860500] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:574; }","duration":"811.759502ms","start":"2026-05-12T05:41:12.471117Z","end":"2026-05-12T05:41:13.282876Z","steps":["trace[176860500] 'agreement among raft nodes before linearized reading'  (duration: 811.534646ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:13.283046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:12.377309Z","time spent":"905.682293ms","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" value_size:64282 >> failure:<>"}
{"level":"info","ts":"2026-05-12T05:41:13.283159Z","caller":"traceutil/trace.go:171","msg":"trace[1604549766] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"881.096872ms","start":"2026-05-12T05:41:12.402056Z","end":"2026-05-12T05:41:13.283153Z","steps":["trace[1604549766] 'process raft request'  (duration: 880.03498ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:13.283211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:12.402039Z","time spent":"881.139763ms","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" mod_revision:561 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" value_size:151109 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" > >"}
{"level":"warn","ts":"2026-05-12T05:41:13.282849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.815015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-12T05:41:13.283436Z","caller":"traceutil/trace.go:171","msg":"trace[674821636] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:574; }","duration":"461.407514ms","start":"2026-05-12T05:41:12.821968Z","end":"2026-05-12T05:41:13.283375Z","steps":["trace[674821636] 'agreement among raft nodes before linearized reading'  (duration: 460.768034ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:13.283184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:12.471095Z","time spent":"811.99332ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-12T05:41:13.283585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:12.821942Z","time spent":"461.588839ms","remote":"127.0.0.1:50278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-12T05:41:19.832783Z","caller":"traceutil/trace.go:171","msg":"trace[1561839145] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"332.536837ms","start":"2026-05-12T05:41:19.500174Z","end":"2026-05-12T05:41:19.832711Z","steps":["trace[1561839145] 'process raft request'  (duration: 304.921285ms)","trace[1561839145] 'compare'  (duration: 27.275561ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:41:19.833065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:19.500142Z","time spent":"332.786884ms","remote":"127.0.0.1:50278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:616 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-12T05:41:20.463077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.188696ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646843345310653296 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.205\" mod_revision:482 > success:<request_put:<key:\"/registry/masterleases/199.204.45.205\" value_size:67 lease:5646843345310653293 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.205\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-12T05:41:20.463239Z","caller":"traceutil/trace.go:171","msg":"trace[458320830] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"562.244623ms","start":"2026-05-12T05:41:19.900968Z","end":"2026-05-12T05:41:20.463212Z","steps":["trace[458320830] 'process raft request'  (duration: 370.750087ms)","trace[458320830] 'compare'  (duration: 190.905448ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:41:20.463336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:19.900946Z","time spent":"562.343985ms","remote":"127.0.0.1:50048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.205\" mod_revision:482 > success:<request_put:<key:\"/registry/masterleases/199.204.45.205\" value_size:67 lease:5646843345310653293 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.205\" > >"}
{"level":"warn","ts":"2026-05-12T05:41:20.965991Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843345310653295,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-12T05:41:21.067195Z","caller":"traceutil/trace.go:171","msg":"trace[779491230] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:662; }","duration":"601.383835ms","start":"2026-05-12T05:41:20.465717Z","end":"2026-05-12T05:41:21.067101Z","steps":["trace[779491230] 'read index received'  (duration: 527.569651ms)","trace[779491230] 'applied index is now lower than readState.Index'  (duration: 73.812094ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:41:21.069218Z","caller":"traceutil/trace.go:171","msg":"trace[1998706482] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"1.156627526s","start":"2026-05-12T05:41:19.912536Z","end":"2026-05-12T05:41:21.069164Z","steps":["trace[1998706482] 'process raft request'  (duration: 1.154434244s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:21.069238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.491886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"warn","ts":"2026-05-12T05:41:21.069286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.214931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:41:21.069382Z","caller":"traceutil/trace.go:171","msg":"trace[1780391803] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:635; }","duration":"603.690201ms","start":"2026-05-12T05:41:20.465652Z","end":"2026-05-12T05:41:21.069343Z","steps":["trace[1780391803] 'agreement among raft nodes before linearized reading'  (duration: 603.415174ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:41:21.069403Z","caller":"traceutil/trace.go:171","msg":"trace[343636920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"600.381216ms","start":"2026-05-12T05:41:20.468985Z","end":"2026-05-12T05:41:21.069366Z","steps":["trace[343636920] 'agreement among raft nodes before linearized reading'  (duration: 600.114409ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:21.069443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:20.465621Z","time spent":"603.807905ms","remote":"127.0.0.1:50156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"warn","ts":"2026-05-12T05:41:21.069453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:20.468974Z","time spent":"600.467428ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-12T05:41:21.069231Z","caller":"traceutil/trace.go:171","msg":"trace[277108463] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.162269418s","start":"2026-05-12T05:41:19.906827Z","end":"2026-05-12T05:41:21.069096Z","steps":["trace[277108463] 'process raft request'  (duration: 1.086774066s)","trace[277108463] 'compare'  (duration: 68.317558ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:41:21.069578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:19.91251Z","time spent":"1.156837573s","remote":"127.0.0.1:50172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-6gn29\" mod_revision:513 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-6gn29\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-6gn29\" > >"}
{"level":"warn","ts":"2026-05-12T05:41:21.071099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:19.906773Z","time spent":"1.162906827s","remote":"127.0.0.1:50088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:628 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036225 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-05-12T05:41:21.834825Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843345310653303,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-12T05:41:22.335776Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843345310653303,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-12T05:41:22.836075Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843345310653303,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-12T05:41:23.336815Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843345310653303,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-12T05:41:23.598451Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.441956802s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-12T05:41:23.610407Z","caller":"traceutil/trace.go:171","msg":"trace[585915516] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:664; }","duration":"2.276632998s","start":"2026-05-12T05:41:21.333739Z","end":"2026-05-12T05:41:23.610372Z","steps":["trace[585915516] 'read index received'  (duration: 2.265123632s)","trace[585915516] 'applied index is now lower than readState.Index'  (duration: 11.507476ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:41:23.610505Z","caller":"traceutil/trace.go:171","msg":"trace[1814060760] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"2.454126686s","start":"2026-05-12T05:41:21.156337Z","end":"2026-05-12T05:41:23.610463Z","steps":["trace[1814060760] 'process raft request'  (duration: 2.442514167s)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:41:23.610501Z","caller":"traceutil/trace.go:171","msg":"trace[661374130] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.365493977s","start":"2026-05-12T05:41:22.244953Z","end":"2026-05-12T05:41:23.610447Z","steps":["trace[661374130] 'process raft request'  (duration: 1.365274951s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:23.610669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:21.156303Z","time spent":"2.45429029s","remote":"127.0.0.1:50254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"warn","ts":"2026-05-12T05:41:23.610716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.276942118s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-12T05:41:23.610784Z","caller":"traceutil/trace.go:171","msg":"trace[908997638] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"2.277065311s","start":"2026-05-12T05:41:21.333691Z","end":"2026-05-12T05:41:23.610756Z","steps":["trace[908997638] 'agreement among raft nodes before linearized reading'  (duration: 2.276840414s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:23.610807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.157955746s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-05-12T05:41:23.610831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:22.244916Z","time spent":"1.365714663s","remote":"127.0.0.1:50278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:562 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-05-12T05:41:23.610832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:21.333657Z","time spent":"2.277166424s","remote":"127.0.0.1:50278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-12T05:41:23.610896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.158042789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-12T05:41:23.610983Z","caller":"traceutil/trace.go:171","msg":"trace[530358605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"2.158138982s","start":"2026-05-12T05:41:21.452822Z","end":"2026-05-12T05:41:23.610961Z","steps":["trace[530358605] 'agreement among raft nodes before linearized reading'  (duration: 2.157855224s)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:41:23.610886Z","caller":"traceutil/trace.go:171","msg":"trace[772548212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"2.15809219s","start":"2026-05-12T05:41:21.452778Z","end":"2026-05-12T05:41:23.61087Z","steps":["trace[772548212] 'agreement among raft nodes before linearized reading'  (duration: 2.157768311s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:23.611045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:21.452751Z","time spent":"2.158283106s","remote":"127.0.0.1:50278","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-05-12T05:41:23.611259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.141374751s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:41:23.611321Z","caller":"traceutil/trace.go:171","msg":"trace[103747500] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"1.141490374s","start":"2026-05-12T05:41:22.469812Z","end":"2026-05-12T05:41:23.611303Z","steps":["trace[103747500] 'agreement among raft nodes before linearized reading'  (duration: 1.141394061s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:23.611384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:22.469762Z","time spent":"1.141611278s","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-12T05:41:23.611059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:21.452751Z","time spent":"2.158295336s","remote":"127.0.0.1:50278","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-05-12T05:41:23.612321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.77412651s","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-05-12T05:41:23.612395Z","caller":"traceutil/trace.go:171","msg":"trace[792985763] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"1.774250423s","start":"2026-05-12T05:41:21.838126Z","end":"2026-05-12T05:41:23.612377Z","steps":["trace[792985763] 'agreement among raft nodes before linearized reading'  (duration: 1.772524974s)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:23.612549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:21.838095Z","time spent":"1.774437669s","remote":"127.0.0.1:50278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-12T05:41:25.516048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.158083ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646843345310653359 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" mod_revision:663 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" value_size:10250 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-12T05:41:25.516172Z","caller":"traceutil/trace.go:171","msg":"trace[443459463] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"451.78259ms","start":"2026-05-12T05:41:25.064368Z","end":"2026-05-12T05:41:25.516151Z","steps":["trace[443459463] 'process raft request'  (duration: 199.3954ms)","trace[443459463] 'compare'  (duration: 251.804864ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:41:25.51624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:25.064356Z","time spent":"451.851452ms","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10353,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" mod_revision:663 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" value_size:10250 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" > >"}
{"level":"info","ts":"2026-05-12T05:41:25.530093Z","caller":"traceutil/trace.go:171","msg":"trace[2093016471] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:698; }","duration":"327.40936ms","start":"2026-05-12T05:41:25.202614Z","end":"2026-05-12T05:41:25.530023Z","steps":["trace[2093016471] 'read index received'  (duration: 61.15639ms)","trace[2093016471] 'applied index is now lower than readState.Index'  (duration: 266.25192ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:41:25.530156Z","caller":"traceutil/trace.go:171","msg":"trace[292466541] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"461.206974ms","start":"2026-05-12T05:41:25.068921Z","end":"2026-05-12T05:41:25.530128Z","steps":["trace[292466541] 'process raft request'  (duration: 460.910396ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:25.530294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.627367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:41:25.530671Z","caller":"traceutil/trace.go:171","msg":"trace[1420174097] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:671; }","duration":"328.056379ms","start":"2026-05-12T05:41:25.202553Z","end":"2026-05-12T05:41:25.53061Z","steps":["trace[1420174097] 'agreement among raft nodes before linearized reading'  (duration: 327.628867ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:25.530871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:25.202525Z","time spent":"328.258835ms","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "}
{"level":"warn","ts":"2026-05-12T05:41:25.531376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:41:25.068887Z","time spent":"461.561834ms","remote":"127.0.0.1:50064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5571,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" mod_revision:668 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" value_size:5473 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" > >"}
{"level":"warn","ts":"2026-05-12T05:41:25.538298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.833461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-12T05:41:25.53829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.918227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-2nwt2\" ","response":"range_response_count:1 size:4888"}
{"level":"info","ts":"2026-05-12T05:41:25.538364Z","caller":"traceutil/trace.go:171","msg":"trace[138340717] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:671; }","duration":"135.978764ms","start":"2026-05-12T05:41:25.402366Z","end":"2026-05-12T05:41:25.538345Z","steps":["trace[138340717] 'agreement among raft nodes before linearized reading'  (duration: 135.866181ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:41:25.53839Z","caller":"traceutil/trace.go:171","msg":"trace[86044377] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-2nwt2; range_end:; response_count:1; response_revision:671; }","duration":"139.074141ms","start":"2026-05-12T05:41:25.399305Z","end":"2026-05-12T05:41:25.538379Z","steps":["trace[86044377] 'agreement among raft nodes before linearized reading'  (duration: 138.826535ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:41:39.300898Z","caller":"traceutil/trace.go:171","msg":"trace[1349616219] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:833; }","duration":"202.786291ms","start":"2026-05-12T05:41:39.098079Z","end":"2026-05-12T05:41:39.300865Z","steps":["trace[1349616219] 'read index received'  (duration: 201.98675ms)","trace[1349616219] 'applied index is now lower than readState.Index'  (duration: 798.001µs)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:41:39.300957Z","caller":"traceutil/trace.go:171","msg":"trace[788238876] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"236.837513ms","start":"2026-05-12T05:41:39.064079Z","end":"2026-05-12T05:41:39.300916Z","steps":["trace[788238876] 'process raft request'  (duration: 236.016211ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:39.301191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.036419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-12T05:41:39.301242Z","caller":"traceutil/trace.go:171","msg":"trace[1136448030] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:801; }","duration":"203.201623ms","start":"2026-05-12T05:41:39.098029Z","end":"2026-05-12T05:41:39.301231Z","steps":["trace[1136448030] 'agreement among raft nodes before linearized reading'  (duration: 202.962557ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:43:40.127997Z","caller":"traceutil/trace.go:171","msg":"trace[429618510] linearizableReadLoop","detail":"{readStateIndex:1430; appliedIndex:1429; }","duration":"113.632789ms","start":"2026-05-12T05:43:40.014335Z","end":"2026-05-12T05:43:40.127968Z","steps":["trace[429618510] 'read index received'  (duration: 106.560336ms)","trace[429618510] 'applied index is now lower than readState.Index'  (duration: 7.070713ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:43:40.128088Z","caller":"traceutil/trace.go:171","msg":"trace[439835950] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"238.536903ms","start":"2026-05-12T05:43:39.889503Z","end":"2026-05-12T05:43:40.12804Z","steps":["trace[439835950] 'process raft request'  (duration: 231.275475ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:43:40.128267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.919795ms","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-05-12T05:43:40.128449Z","caller":"traceutil/trace.go:171","msg":"trace[1541027118] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1370; }","duration":"114.210893ms","start":"2026-05-12T05:43:40.014222Z","end":"2026-05-12T05:43:40.128433Z","steps":["trace[1541027118] 'agreement among raft nodes before linearized reading'  (duration: 113.875915ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:43:40.163636Z","caller":"traceutil/trace.go:171","msg":"trace[1068609570] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"135.439426ms","start":"2026-05-12T05:43:40.028177Z","end":"2026-05-12T05:43:40.163616Z","steps":["trace[1068609570] 'process raft request'  (duration: 135.323603ms)"],"step_count":1}