{"level":"warn","ts":"2026-04-21T18:08:12.455807Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-21T18:08:12.4559Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.23:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.23:2380","--initial-cluster=instance=https://199.19.213.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.23: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-04-21T18:08:12.455971Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-21T18:08:12.455983Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.23:2380"]} {"level":"info","ts":"2026-04-21T18:08:12.455998Z","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-04-21T18:08:12.456598Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.23:2379"]} {"level":"info","ts":"2026-04-21T18:08:12.45667Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.23:2380"],"listen-peer-urls":["https://199.19.213.23:2380"],"advertise-client-urls":["https://199.19.213.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.23: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-04-21T18:08:12.462178Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.261574ms"} {"level":"info","ts":"2026-04-21T18:08:12.472735Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1812db8446d3ac67","cluster-id":"57ff06cb872baa33"} {"level":"info","ts":"2026-04-21T18:08:12.472813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T18:08:12.472864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became follower at term 0"} {"level":"info","ts":"2026-04-21T18:08:12.472883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1812db8446d3ac67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T18:08:12.472892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became follower at term 1"} {"level":"info","ts":"2026-04-21T18:08:12.472933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 switched to configuration voters=(1734690167661505639)"} {"level":"warn","ts":"2026-04-21T18:08:12.479508Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T18:08:12.481025Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T18:08:12.48229Z","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-04-21T18:08:12.484457Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1812db8446d3ac67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T18:08:12.489486Z","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-04-21T18:08:12.490106Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1812db8446d3ac67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T18:08:12.490042Z","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-04-21T18:08:12.490246Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.23:2380"} {"level":"info","ts":"2026-04-21T18:08:12.490275Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.23:2380"} {"level":"info","ts":"2026-04-21T18:08:12.490301Z","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-04-21T18:08:12.49032Z","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-04-21T18:08:12.490353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 switched to configuration voters=(1734690167661505639)"} {"level":"info","ts":"2026-04-21T18:08:12.490467Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1812db8446d3ac67","initial-advertise-peer-urls":["https://199.19.213.23:2380"],"listen-peer-urls":["https://199.19.213.23:2380"],"advertise-client-urls":["https://199.19.213.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T18:08:12.490501Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T18:08:12.490506Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"57ff06cb872baa33","local-member-id":"1812db8446d3ac67","added-peer-id":"1812db8446d3ac67","added-peer-peer-urls":["https://199.19.213.23:2380"]} {"level":"info","ts":"2026-04-21T18:08:13.073198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T18:08:13.07324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T18:08:13.073262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 received MsgPreVoteResp from 1812db8446d3ac67 at term 1"} {"level":"info","ts":"2026-04-21T18:08:13.073272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became candidate at term 2"} {"level":"info","ts":"2026-04-21T18:08:13.073277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 received MsgVoteResp from 1812db8446d3ac67 at term 2"} {"level":"info","ts":"2026-04-21T18:08:13.073285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became leader at term 2"} {"level":"info","ts":"2026-04-21T18:08:13.073292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1812db8446d3ac67 elected leader 1812db8446d3ac67 at term 2"} {"level":"info","ts":"2026-04-21T18:08:13.074282Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T18:08:13.075177Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T18:08:13.07519Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1812db8446d3ac67","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.23:2379]}","request-path":"/0/members/1812db8446d3ac67/attributes","cluster-id":"57ff06cb872baa33","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T18:08:13.075577Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T18:08:13.076143Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T18:08:13.076217Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T18:08:13.07807Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.23:2379"} {"level":"info","ts":"2026-04-21T18:08:13.078308Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"57ff06cb872baa33","local-member-id":"1812db8446d3ac67","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T18:08:13.078392Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T18:08:13.078416Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T18:08:13.078971Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T18:08:15.384243Z","caller":"traceutil/trace.go:171","msg":"trace[1886643807] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"142.85438ms","start":"2026-04-21T18:08:15.241358Z","end":"2026-04-21T18:08:15.384212Z","steps":["trace[1886643807] 'read index received' (duration: 142.566147ms)","trace[1886643807] 'applied index is now lower than readState.Index' (duration: 287.253µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:08:15.384315Z","caller":"traceutil/trace.go:171","msg":"trace[1351351510] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"143.099842ms","start":"2026-04-21T18:08:15.241187Z","end":"2026-04-21T18:08:15.384287Z","steps":["trace[1351351510] 'process raft request' (duration: 142.83241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:08:15.384552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.168722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T18:08:15.38463Z","caller":"traceutil/trace.go:171","msg":"trace[1222254505] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:72; }","duration":"143.277142ms","start":"2026-04-21T18:08:15.241342Z","end":"2026-04-21T18:08:15.384619Z","steps":["trace[1222254505] 'agreement among raft nodes before linearized reading' (duration: 143.030211ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:08:44.26556Z","caller":"traceutil/trace.go:171","msg":"trace[620645007] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:563; }","duration":"227.586402ms","start":"2026-04-21T18:08:44.037948Z","end":"2026-04-21T18:08:44.265534Z","steps":["trace[620645007] 'read index received' (duration: 227.268493ms)","trace[620645007] 'applied index is now lower than readState.Index' (duration: 317.159µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:08:44.265908Z","caller":"traceutil/trace.go:171","msg":"trace[332804436] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"228.463996ms","start":"2026-04-21T18:08:44.037433Z","end":"2026-04-21T18:08:44.265897Z","steps":["trace[332804436] 'process raft request' (duration: 227.88966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:08:44.266174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.20605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:29476"} {"level":"info","ts":"2026-04-21T18:08:44.266257Z","caller":"traceutil/trace.go:171","msg":"trace[101196805] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:545; }","duration":"228.306242ms","start":"2026-04-21T18:08:44.037932Z","end":"2026-04-21T18:08:44.266238Z","steps":["trace[101196805] 'agreement among raft nodes before linearized reading' (duration: 228.135407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:08:44.26637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.61107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T18:08:44.266471Z","caller":"traceutil/trace.go:171","msg":"trace[283766296] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:545; }","duration":"107.754744ms","start":"2026-04-21T18:08:44.15869Z","end":"2026-04-21T18:08:44.266445Z","steps":["trace[283766296] 'agreement among raft nodes before linearized reading' (duration: 107.600009ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:08:48.650289Z","caller":"traceutil/trace.go:171","msg":"trace[326102427] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"128.098244ms","start":"2026-04-21T18:08:48.522162Z","end":"2026-04-21T18:08:48.65026Z","steps":["trace[326102427] 'read index received' (duration: 127.245471ms)","trace[326102427] 'applied index is now lower than readState.Index' (duration: 851.833µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T18:08:48.650554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.367301ms","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-04-21T18:08:48.650592Z","caller":"traceutil/trace.go:171","msg":"trace[1328401012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"128.475054ms","start":"2026-04-21T18:08:48.522103Z","end":"2026-04-21T18:08:48.650578Z","steps":["trace[1328401012] 'agreement among raft nodes before linearized reading' (duration: 128.255768ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:08:48.651068Z","caller":"traceutil/trace.go:171","msg":"trace[1726648472] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"178.403357ms","start":"2026-04-21T18:08:48.47253Z","end":"2026-04-21T18:08:48.650933Z","steps":["trace[1726648472] 'process raft request' (duration: 177.135742ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:08:49.025459Z","caller":"traceutil/trace.go:171","msg":"trace[780434510] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"302.294561ms","start":"2026-04-21T18:08:48.723121Z","end":"2026-04-21T18:08:49.025415Z","steps":["trace[780434510] 'read index received' (duration: 302.025724ms)","trace[780434510] 'applied index is now lower than readState.Index' (duration: 267.677µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:08:49.025555Z","caller":"traceutil/trace.go:171","msg":"trace[1702075867] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"319.848888ms","start":"2026-04-21T18:08:48.705665Z","end":"2026-04-21T18:08:49.025514Z","steps":["trace[1702075867] 'process raft request' (duration: 319.580611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:08:49.02572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.545927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ptdwj\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-04-21T18:08:49.025739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.348356ms","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-04-21T18:08:49.025763Z","caller":"traceutil/trace.go:171","msg":"trace[1891688297] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ptdwj; range_end:; response_count:1; response_revision:575; }","duration":"302.66244ms","start":"2026-04-21T18:08:48.723089Z","end":"2026-04-21T18:08:49.025751Z","steps":["trace[1891688297] 'agreement among raft nodes before linearized reading' (duration: 302.487025ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:08:49.025818Z","caller":"traceutil/trace.go:171","msg":"trace[636571844] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:575; }","duration":"201.46001ms","start":"2026-04-21T18:08:48.824334Z","end":"2026-04-21T18:08:49.025794Z","steps":["trace[636571844] 'agreement among raft nodes before linearized reading' (duration: 201.310846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:08:49.025825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.428167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T18:08:49.025882Z","caller":"traceutil/trace.go:171","msg":"trace[123239622] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"201.509331ms","start":"2026-04-21T18:08:48.824358Z","end":"2026-04-21T18:08:49.025868Z","steps":["trace[123239622] 'agreement among raft nodes before linearized reading' (duration: 201.343966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:08:49.025824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T18:08:48.723075Z","time spent":"302.740712ms","remote":"127.0.0.1:39156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-ptdwj\" "} {"level":"warn","ts":"2026-04-21T18:08:49.026121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T18:08:48.705647Z","time spent":"320.009253ms","remote":"127.0.0.1:39322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T18:08:49.448791Z","caller":"traceutil/trace.go:171","msg":"trace[2099903723] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"417.589905ms","start":"2026-04-21T18:08:49.031163Z","end":"2026-04-21T18:08:49.448752Z","steps":["trace[2099903723] 'process raft request' (duration: 361.47072ms)","trace[2099903723] 'compare' (duration: 55.285463ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:08:49.44885Z","caller":"traceutil/trace.go:171","msg":"trace[27345678] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"408.52447ms","start":"2026-04-21T18:08:49.040293Z","end":"2026-04-21T18:08:49.448818Z","steps":["trace[27345678] 'process raft request' (duration: 408.213912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:08:49.44897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.092184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T18:08:49.449165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T18:08:49.031102Z","time spent":"417.778261ms","remote":"127.0.0.1:39230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T18:08:49.448803Z","caller":"traceutil/trace.go:171","msg":"trace[64175838] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:595; }","duration":"412.921239ms","start":"2026-04-21T18:08:49.035835Z","end":"2026-04-21T18:08:49.448756Z","steps":["trace[64175838] 'read index received' (duration: 23.955498ms)","trace[64175838] 'applied index is now lower than readState.Index' (duration: 388.964671ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:08:49.449025Z","caller":"traceutil/trace.go:171","msg":"trace[1373496641] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:578; }","duration":"413.204276ms","start":"2026-04-21T18:08:49.035809Z","end":"2026-04-21T18:08:49.449013Z","steps":["trace[1373496641] 'agreement among raft nodes before linearized reading' (duration: 413.091743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:08:49.449294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T18:08:49.0358Z","time spent":"413.479195ms","remote":"127.0.0.1:39468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"warn","ts":"2026-04-21T18:08:49.449365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T18:08:49.040282Z","time spent":"408.648963ms","remote":"127.0.0.1:39156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T18:08:49.44936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.45993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T18:08:49.449527Z","caller":"traceutil/trace.go:171","msg":"trace[274107323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"291.663684ms","start":"2026-04-21T18:08:49.157851Z","end":"2026-04-21T18:08:49.449515Z","steps":["trace[274107323] 'agreement among raft nodes before linearized reading' (duration: 291.452159ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:08:50.283731Z","caller":"traceutil/trace.go:171","msg":"trace[1758953093] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"125.241197ms","start":"2026-04-21T18:08:50.158464Z","end":"2026-04-21T18:08:50.283705Z","steps":["trace[1758953093] 'read index received' (duration: 124.329593ms)","trace[1758953093] 'applied index is now lower than readState.Index' (duration: 910.574µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T18:08:50.283874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.39297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T18:08:50.283801Z","caller":"traceutil/trace.go:171","msg":"trace[1186535637] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"443.393244ms","start":"2026-04-21T18:08:49.840372Z","end":"2026-04-21T18:08:50.283766Z","steps":["trace[1186535637] 'process raft request' (duration: 442.704346ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:08:50.283919Z","caller":"traceutil/trace.go:171","msg":"trace[1980367797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"125.508634ms","start":"2026-04-21T18:08:50.158397Z","end":"2026-04-21T18:08:50.283905Z","steps":["trace[1980367797] 'agreement among raft nodes before linearized reading' (duration: 125.4043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:08:50.284137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T18:08:49.840347Z","time spent":"443.622652ms","remote":"127.0.0.1:39076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T18:09:06.486624Z","caller":"traceutil/trace.go:171","msg":"trace[507787851] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"234.593076ms","start":"2026-04-21T18:09:06.252003Z","end":"2026-04-21T18:09:06.486596Z","steps":["trace[507787851] 'process raft request' (duration: 164.240577ms)","trace[507787851] 'compare' (duration: 70.232266ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:10:24.283164Z","caller":"traceutil/trace.go:171","msg":"trace[1978882970] linearizableReadLoop","detail":"{readStateIndex:1900; appliedIndex:1899; }","duration":"171.680735ms","start":"2026-04-21T18:10:24.111443Z","end":"2026-04-21T18:10:24.283124Z","steps":["trace[1978882970] 'read index received' (duration: 171.427802ms)","trace[1978882970] 'applied index is now lower than readState.Index' (duration: 251.843µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:10:24.283244Z","caller":"traceutil/trace.go:171","msg":"trace[820732115] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"181.891613ms","start":"2026-04-21T18:10:24.10127Z","end":"2026-04-21T18:10:24.283162Z","steps":["trace[820732115] 'process raft request' (duration: 181.68671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:10:24.283482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.009849ms","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":"warn","ts":"2026-04-21T18:10:24.283497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.002278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T18:10:24.28353Z","caller":"traceutil/trace.go:171","msg":"trace[494478862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1830; }","duration":"124.074188ms","start":"2026-04-21T18:10:24.159445Z","end":"2026-04-21T18:10:24.28352Z","steps":["trace[494478862] 'agreement among raft nodes before linearized reading' (duration: 123.997077ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:10:24.283602Z","caller":"traceutil/trace.go:171","msg":"trace[1387674050] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1830; }","duration":"172.07434ms","start":"2026-04-21T18:10:24.111437Z","end":"2026-04-21T18:10:24.283512Z","steps":["trace[1387674050] 'agreement among raft nodes before linearized reading' (duration: 171.908958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:10:24.283899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.507191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-21T18:10:24.28394Z","caller":"traceutil/trace.go:171","msg":"trace[792209594] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1830; }","duration":"114.589403ms","start":"2026-04-21T18:10:24.16934Z","end":"2026-04-21T18:10:24.283929Z","steps":["trace[792209594] 'agreement among raft nodes before linearized reading' (duration: 114.436131ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:10:24.782179Z","caller":"traceutil/trace.go:171","msg":"trace[2144383197] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"491.996048ms","start":"2026-04-21T18:10:24.290154Z","end":"2026-04-21T18:10:24.78215Z","steps":["trace[2144383197] 'process raft request' (duration: 480.582436ms)","trace[2144383197] 'compare' (duration: 10.722133ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T18:10:24.782368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T18:10:24.290132Z","time spent":"492.158491ms","remote":"127.0.0.1:39156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T18:10:25.380231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.260207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T18:10:25.380316Z","caller":"traceutil/trace.go:171","msg":"trace[1083322333] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1832; }","duration":"261.382948ms","start":"2026-04-21T18:10:25.118909Z","end":"2026-04-21T18:10:25.380292Z","steps":["trace[1083322333] 'count revisions from in-memory index tree' (duration: 261.186386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:10:25.380335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.409187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-21T18:10:25.380394Z","caller":"traceutil/trace.go:171","msg":"trace[1598905522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1832; }","duration":"384.509488ms","start":"2026-04-21T18:10:24.995869Z","end":"2026-04-21T18:10:25.380379Z","steps":["trace[1598905522] 'range keys from in-memory index tree' (duration: 384.284785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:10:25.380417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T18:10:24.99585Z","time spent":"384.561839ms","remote":"127.0.0.1:39230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T18:10:25.38059Z","caller":"traceutil/trace.go:171","msg":"trace[1662785054] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"260.899883ms","start":"2026-04-21T18:10:25.119667Z","end":"2026-04-21T18:10:25.380567Z","steps":["trace[1662785054] 'process raft request' (duration: 243.668864ms)","trace[1662785054] 'compare' (duration: 16.598241ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T18:10:25.380719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.773586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-51dd0f04-5f71-498e-a150-b2080c4cbcf7\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-04-21T18:10:25.38077Z","caller":"traceutil/trace.go:171","msg":"trace[1231454336] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-51dd0f04-5f71-498e-a150-b2080c4cbcf7; range_end:; response_count:1; response_revision:1832; }","duration":"486.856357ms","start":"2026-04-21T18:10:24.893896Z","end":"2026-04-21T18:10:25.380752Z","steps":["trace[1231454336] 'range keys from in-memory index tree' (duration: 486.660864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:10:25.380802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T18:10:24.893876Z","time spent":"486.917998ms","remote":"127.0.0.1:39156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3768,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-51dd0f04-5f71-498e-a150-b2080c4cbcf7\" "} {"level":"info","ts":"2026-04-21T18:10:37.591398Z","caller":"traceutil/trace.go:171","msg":"trace[1628511456] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"113.946471ms","start":"2026-04-21T18:10:37.477404Z","end":"2026-04-21T18:10:37.591351Z","steps":["trace[1628511456] 'process raft request' (duration: 113.694168ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:10:37.741405Z","caller":"traceutil/trace.go:171","msg":"trace[1636042664] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"143.92817ms","start":"2026-04-21T18:10:37.597336Z","end":"2026-04-21T18:10:37.741265Z","steps":["trace[1636042664] 'process raft request' (duration: 87.80455ms)","trace[1636042664] 'compare' (duration: 55.786205ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:10:39.880972Z","caller":"traceutil/trace.go:171","msg":"trace[502400663] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"122.547277ms","start":"2026-04-21T18:10:39.758396Z","end":"2026-04-21T18:10:39.880944Z","steps":["trace[502400663] 'process raft request' (duration: 122.342974ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:10:39.891245Z","caller":"traceutil/trace.go:171","msg":"trace[742573490] linearizableReadLoop","detail":"{readStateIndex:2035; appliedIndex:2033; }","duration":"126.408446ms","start":"2026-04-21T18:10:39.764813Z","end":"2026-04-21T18:10:39.891221Z","steps":["trace[742573490] 'read index received' (duration: 116.009575ms)","trace[742573490] 'applied index is now lower than readState.Index' (duration: 10.397861ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:10:39.891401Z","caller":"traceutil/trace.go:171","msg":"trace[384452387] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"132.227669ms","start":"2026-04-21T18:10:39.759139Z","end":"2026-04-21T18:10:39.891366Z","steps":["trace[384452387] 'process raft request' (duration: 131.949755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:10:39.891652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.803171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T18:10:39.891719Z","caller":"traceutil/trace.go:171","msg":"trace[1082269753] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1961; }","duration":"126.899412ms","start":"2026-04-21T18:10:39.764805Z","end":"2026-04-21T18:10:39.891704Z","steps":["trace[1082269753] 'agreement among raft nodes before linearized reading' (duration: 126.517637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:11:04.131254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.928901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T18:11:04.131355Z","caller":"traceutil/trace.go:171","msg":"trace[1901703033] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2095; }","duration":"132.069713ms","start":"2026-04-21T18:11:03.999268Z","end":"2026-04-21T18:11:04.131338Z","steps":["trace[1901703033] 'count revisions from in-memory index tree' (duration: 131.866901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:11:04.131416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.458467ms","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-04-21T18:11:04.131519Z","caller":"traceutil/trace.go:171","msg":"trace[1896408616] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2095; }","duration":"125.617949ms","start":"2026-04-21T18:11:04.005886Z","end":"2026-04-21T18:11:04.131504Z","steps":["trace[1896408616] 'range keys from in-memory index tree' (duration: 125.322856ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:11:04.471812Z","caller":"traceutil/trace.go:171","msg":"trace[1820707380] linearizableReadLoop","detail":"{readStateIndex:2176; appliedIndex:2175; }","duration":"238.841335ms","start":"2026-04-21T18:11:04.232918Z","end":"2026-04-21T18:11:04.471759Z","steps":["trace[1820707380] 'read index received' (duration: 174.072147ms)","trace[1820707380] 'applied index is now lower than readState.Index' (duration: 64.768128ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T18:11:04.472009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.071668ms","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-04-21T18:11:04.472046Z","caller":"traceutil/trace.go:171","msg":"trace[181745108] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2097; }","duration":"239.151309ms","start":"2026-04-21T18:11:04.232885Z","end":"2026-04-21T18:11:04.472036Z","steps":["trace[181745108] 'agreement among raft nodes before linearized reading' (duration: 238.997437ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:11:04.472281Z","caller":"traceutil/trace.go:171","msg":"trace[1122442846] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"282.358066ms","start":"2026-04-21T18:11:04.18991Z","end":"2026-04-21T18:11:04.472268Z","steps":["trace[1122442846] 'process raft request' (duration: 217.193514ms)","trace[1122442846] 'compare' (duration: 64.547395ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:11:06.076101Z","caller":"traceutil/trace.go:171","msg":"trace[1246809725] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"250.306516ms","start":"2026-04-21T18:11:05.825766Z","end":"2026-04-21T18:11:06.076072Z","steps":["trace[1246809725] 'process raft request' (duration: 250.180164ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:11:06.076322Z","caller":"traceutil/trace.go:171","msg":"trace[1317904497] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"250.525858ms","start":"2026-04-21T18:11:05.825767Z","end":"2026-04-21T18:11:06.076292Z","steps":["trace[1317904497] 'process raft request' (duration: 250.038133ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:11:06.09215Z","caller":"traceutil/trace.go:171","msg":"trace[649921403] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"110.134223ms","start":"2026-04-21T18:11:05.981993Z","end":"2026-04-21T18:11:06.092127Z","steps":["trace[649921403] 'process raft request' (duration: 109.750929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:11:06.35847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.843374ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-04-21T18:11:06.35859Z","caller":"traceutil/trace.go:171","msg":"trace[1613894879] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2184; }","duration":"200.055834ms","start":"2026-04-21T18:11:06.158513Z","end":"2026-04-21T18:11:06.358568Z","steps":["trace[1613894879] 'read index received' (duration: 11.837245ms)","trace[1613894879] 'applied index is now lower than readState.Index' (duration: 188.216689ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T18:11:06.358838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.273238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-21T18:11:06.358804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.267786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T18:11:06.358897Z","caller":"traceutil/trace.go:171","msg":"trace[1553851424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2105; }","duration":"194.368678ms","start":"2026-04-21T18:11:06.164513Z","end":"2026-04-21T18:11:06.358882Z","steps":["trace[1553851424] 'agreement among raft nodes before linearized reading' (duration: 194.182346ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:11:06.358929Z","caller":"traceutil/trace.go:171","msg":"trace[77140491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2105; }","duration":"200.429597ms","start":"2026-04-21T18:11:06.158477Z","end":"2026-04-21T18:11:06.358907Z","steps":["trace[77140491] 'agreement among raft nodes before linearized reading' (duration: 200.178465ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:11:06.497339Z","caller":"traceutil/trace.go:171","msg":"trace[2042653591] linearizableReadLoop","detail":"{readStateIndex:2186; appliedIndex:2185; }","duration":"137.149023ms","start":"2026-04-21T18:11:06.360166Z","end":"2026-04-21T18:11:06.497315Z","steps":["trace[2042653591] 'read index received' (duration: 123.82229ms)","trace[2042653591] 'applied index is now lower than readState.Index' (duration: 13.325323ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:11:06.497351Z","caller":"traceutil/trace.go:171","msg":"trace[1333490777] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"137.788061ms","start":"2026-04-21T18:11:06.359534Z","end":"2026-04-21T18:11:06.497322Z","steps":["trace[1333490777] 'process raft request' (duration: 124.432648ms)","trace[1333490777] 'compare' (duration: 13.123301ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T18:11:06.497498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.302425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T18:11:06.497559Z","caller":"traceutil/trace.go:171","msg":"trace[1424340775] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2106; }","duration":"137.396806ms","start":"2026-04-21T18:11:06.360149Z","end":"2026-04-21T18:11:06.497545Z","steps":["trace[1424340775] 'agreement among raft nodes before linearized reading' (duration: 137.241084ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:11:06.507718Z","caller":"traceutil/trace.go:171","msg":"trace[698769582] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"145.451598ms","start":"2026-04-21T18:11:06.36225Z","end":"2026-04-21T18:11:06.507701Z","steps":["trace[698769582] 'process raft request' (duration: 145.197756ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:11:55.727352Z","caller":"traceutil/trace.go:171","msg":"trace[1075981382] transaction","detail":"{read_only:false; response_revision:2421; number_of_response:1; }","duration":"106.293233ms","start":"2026-04-21T18:11:55.621045Z","end":"2026-04-21T18:11:55.727338Z","steps":["trace[1075981382] 'process raft request' (duration: 104.609536ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:12:04.087485Z","caller":"traceutil/trace.go:171","msg":"trace[1547456976] transaction","detail":"{read_only:false; response_revision:2521; number_of_response:1; }","duration":"243.261056ms","start":"2026-04-21T18:12:03.844201Z","end":"2026-04-21T18:12:04.087462Z","steps":["trace[1547456976] 'process raft request' (duration: 243.137555ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:12:36.668463Z","caller":"traceutil/trace.go:171","msg":"trace[726545703] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"165.637682ms","start":"2026-04-21T18:12:36.502796Z","end":"2026-04-21T18:12:36.668433Z","steps":["trace[726545703] 'process raft request' (duration: 165.469537ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:16:19.050427Z","caller":"traceutil/trace.go:171","msg":"trace[1194010870] linearizableReadLoop","detail":"{readStateIndex:4765; appliedIndex:4763; }","duration":"122.362991ms","start":"2026-04-21T18:16:18.928041Z","end":"2026-04-21T18:16:19.050404Z","steps":["trace[1194010870] 'read index received' (duration: 37.739553ms)","trace[1194010870] 'applied index is now lower than readState.Index' (duration: 84.622518ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:16:19.050564Z","caller":"traceutil/trace.go:171","msg":"trace[51238075] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4590; }","duration":"125.994424ms","start":"2026-04-21T18:16:18.924541Z","end":"2026-04-21T18:16:19.050535Z","steps":["trace[51238075] 'process raft request' (duration: 125.760411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:16:19.050872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.812059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-04-21T18:16:19.050979Z","caller":"traceutil/trace.go:171","msg":"trace[1124933878] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4590; }","duration":"122.93208ms","start":"2026-04-21T18:16:18.928008Z","end":"2026-04-21T18:16:19.05094Z","steps":["trace[1124933878] 'agreement among raft nodes before linearized reading' (duration: 122.523134ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:16:19.302557Z","caller":"traceutil/trace.go:171","msg":"trace[259362560] linearizableReadLoop","detail":"{readStateIndex:4771; appliedIndex:4770; }","duration":"102.408183ms","start":"2026-04-21T18:16:19.200124Z","end":"2026-04-21T18:16:19.302532Z","steps":["trace[259362560] 'read index received' (duration: 72.889248ms)","trace[259362560] 'applied index is now lower than readState.Index' (duration: 29.517675ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:16:19.302714Z","caller":"traceutil/trace.go:171","msg":"trace[190572444] transaction","detail":"{read_only:false; response_revision:4596; number_of_response:1; }","duration":"105.794372ms","start":"2026-04-21T18:16:19.196879Z","end":"2026-04-21T18:16:19.302673Z","steps":["trace[190572444] 'process raft request' (duration: 76.198506ms)","trace[190572444] 'compare' (duration: 29.332882ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T18:16:19.302971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.818528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-04-21T18:16:19.303068Z","caller":"traceutil/trace.go:171","msg":"trace[1620113138] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4596; }","duration":"102.946061ms","start":"2026-04-21T18:16:19.200101Z","end":"2026-04-21T18:16:19.303047Z","steps":["trace[1620113138] 'agreement among raft nodes before linearized reading' (duration: 102.645047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:16:19.302992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.722468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-04-21T18:16:19.303308Z","caller":"traceutil/trace.go:171","msg":"trace[934150113] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4596; }","duration":"103.031702ms","start":"2026-04-21T18:16:19.200207Z","end":"2026-04-21T18:16:19.303239Z","steps":["trace[934150113] 'agreement among raft nodes before linearized reading' (duration: 102.576645ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:16:25.558941Z","caller":"traceutil/trace.go:171","msg":"trace[237877229] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"209.83203ms","start":"2026-04-21T18:16:25.349059Z","end":"2026-04-21T18:16:25.558891Z","steps":["trace[237877229] 'process raft request' (duration: 209.691438ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:16:25.602289Z","caller":"traceutil/trace.go:171","msg":"trace[1513212691] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"145.25425ms","start":"2026-04-21T18:16:25.457004Z","end":"2026-04-21T18:16:25.602259Z","steps":["trace[1513212691] 'process raft request' (duration: 144.974056ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:16:26.093868Z","caller":"traceutil/trace.go:171","msg":"trace[507927844] linearizableReadLoop","detail":"{readStateIndex:4893; appliedIndex:4891; }","duration":"223.562663ms","start":"2026-04-21T18:16:25.870285Z","end":"2026-04-21T18:16:26.093848Z","steps":["trace[507927844] 'read index received' (duration: 6.147027ms)","trace[507927844] 'applied index is now lower than readState.Index' (duration: 217.414756ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:16:26.093906Z","caller":"traceutil/trace.go:171","msg":"trace[22532705] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"243.523688ms","start":"2026-04-21T18:16:25.850359Z","end":"2026-04-21T18:16:26.093883Z","steps":["trace[22532705] 'process raft request' (duration: 243.382886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:16:26.094098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.005228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-21T18:16:26.094161Z","caller":"traceutil/trace.go:171","msg":"trace[1175683729] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4716; }","duration":"193.113699ms","start":"2026-04-21T18:16:25.901029Z","end":"2026-04-21T18:16:26.094142Z","steps":["trace[1175683729] 'agreement among raft nodes before linearized reading' (duration: 192.957687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:16:26.094179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.898725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-21T18:16:26.094099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.797658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12972"} {"level":"info","ts":"2026-04-21T18:16:26.094262Z","caller":"traceutil/trace.go:171","msg":"trace[1436252304] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:4716; }","duration":"103.006586ms","start":"2026-04-21T18:16:25.991237Z","end":"2026-04-21T18:16:26.094244Z","steps":["trace[1436252304] 'agreement among raft nodes before linearized reading' (duration: 102.905485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:16:26.094337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.720057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-21T18:16:26.094336Z","caller":"traceutil/trace.go:171","msg":"trace[1488778292] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4716; }","duration":"224.051851ms","start":"2026-04-21T18:16:25.870246Z","end":"2026-04-21T18:16:26.094297Z","steps":["trace[1488778292] 'agreement among raft nodes before linearized reading' (duration: 223.683086ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:16:26.094406Z","caller":"traceutil/trace.go:171","msg":"trace[1974273242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4716; }","duration":"115.837848ms","start":"2026-04-21T18:16:25.978553Z","end":"2026-04-21T18:16:26.094391Z","steps":["trace[1974273242] 'agreement among raft nodes before linearized reading' (duration: 115.594105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:16:26.243142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.220409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16231"} {"level":"warn","ts":"2026-04-21T18:16:26.24318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.688766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-3a67ddd2-d6e2-4cbc-bd6f-de037baea88c\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-04-21T18:16:26.243217Z","caller":"traceutil/trace.go:171","msg":"trace[548637078] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4724; }","duration":"103.31214ms","start":"2026-04-21T18:16:26.139887Z","end":"2026-04-21T18:16:26.243199Z","steps":["trace[548637078] 'agreement among raft nodes before linearized reading' (duration: 103.144688ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:16:26.243225Z","caller":"traceutil/trace.go:171","msg":"trace[1828470201] range","detail":"{range_begin:/registry/persistentvolumes/pvc-3a67ddd2-d6e2-4cbc-bd6f-de037baea88c; range_end:; response_count:1; response_revision:4724; }","duration":"103.748987ms","start":"2026-04-21T18:16:26.139462Z","end":"2026-04-21T18:16:26.243211Z","steps":["trace[1828470201] 'agreement among raft nodes before linearized reading' (duration: 103.646315ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:16:39.127938Z","caller":"traceutil/trace.go:171","msg":"trace[1617514595] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"105.583685ms","start":"2026-04-21T18:16:39.022327Z","end":"2026-04-21T18:16:39.127911Z","steps":["trace[1617514595] 'process raft request' (duration: 105.259901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T18:17:08.175888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.457337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-21T18:17:08.17596Z","caller":"traceutil/trace.go:171","msg":"trace[389847463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5178; }","duration":"110.567678ms","start":"2026-04-21T18:17:08.065375Z","end":"2026-04-21T18:17:08.175943Z","steps":["trace[389847463] 'range keys from in-memory index tree' (duration: 110.261165ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:18:13.109232Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2897} {"level":"info","ts":"2026-04-21T18:18:13.226078Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2897,"took":"115.023251ms","hash":448918395,"current-db-size-bytes":54599680,"current-db-size":"55 MB","current-db-size-in-use-bytes":29736960,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-21T18:18:13.226161Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":448918395,"revision":2897,"compact-revision":-1} {"level":"info","ts":"2026-04-21T18:20:40.742744Z","caller":"traceutil/trace.go:171","msg":"trace[459316537] transaction","detail":"{read_only:false; response_revision:6658; number_of_response:1; }","duration":"174.716788ms","start":"2026-04-21T18:20:40.568007Z","end":"2026-04-21T18:20:40.742724Z","steps":["trace[459316537] 'process raft request' (duration: 128.091514ms)","trace[459316537] 'compare' (duration: 46.056468ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T18:20:41.391436Z","caller":"traceutil/trace.go:171","msg":"trace[1926814431] transaction","detail":"{read_only:false; response_revision:6660; number_of_response:1; }","duration":"149.887573ms","start":"2026-04-21T18:20:41.241527Z","end":"2026-04-21T18:20:41.391414Z","steps":["trace[1926814431] 'process raft request' (duration: 149.779342ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T18:23:13.115569Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5654} {"level":"info","ts":"2026-04-21T18:23:13.22122Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5654,"took":"104.297963ms","hash":204688148,"current-db-size-bytes":54599680,"current-db-size":"55 MB","current-db-size-in-use-bytes":18432000,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-21T18:23:13.22128Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":204688148,"revision":5654,"compact-revision":2897}